builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1505933059.16 results: success (0) revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.160467) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.165079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.165348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.205051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.205325) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 11:44:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.2M=0s 2017-09-20 11:44:19 (49.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.362599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.362898) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020213 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.416940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.417276) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --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 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 11:44:19,369 truncating revision to first 12 chars 2017-09-20 11:44:19,369 Setting DEBUG logging. 2017-09-20 11:44:19,370 attempt 1/10 2017-09-20 11:44:19,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b5664b73b5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 11:44:19,617 unpacking tar archive at: mozilla-central-7b5664b73b5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.988936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.992225) ========= script_repo_revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.992569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:19.992821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:44:20.005369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 11:44:20.005641) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:44:20 INFO - MultiFileLogger online at 20170920 11:44:20 in /builds/slave/test 11:44:20 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 11:44:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:20 INFO - {'append_to_log': False, 11:44:20 INFO - 'base_work_dir': '/builds/slave/test', 11:44:20 INFO - 'blob_upload_branch': 'Firefox', 11:44:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:20 INFO - 'branch': 'Firefox', 11:44:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:20 INFO - 'code_coverage': False, 11:44:20 INFO - 'config_files': ('talos/linux_config.py',), 11:44:20 INFO - 'default_actions': ('clobber', 11:44:20 INFO - 'read-buildbot-config', 11:44:20 INFO - 'download-and-extract', 11:44:20 INFO - 'populate-webroot', 11:44:20 INFO - 'create-virtualenv', 11:44:20 INFO - 'install', 11:44:20 INFO - 'setup-mitmproxy', 11:44:20 INFO - 'run-tests'), 11:44:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:20 INFO - 'disable_ccov_upload': False, 11:44:20 INFO - 'disable_stylo': False, 11:44:20 INFO - 'download_minidump_stackwalk': True, 11:44:20 INFO - 'download_symbols': 'ondemand', 11:44:20 INFO - 'enable_stylo': False, 11:44:20 INFO - 'enable_webrender': False, 11:44:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:44:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:20 INFO - 'gecko_profile': False, 11:44:20 INFO - 'gecko_profile_interval': 0, 11:44:20 INFO - 'installer_path': 'installer.exe', 11:44:20 INFO - 'log_level': 'info', 11:44:20 INFO - 'log_name': 'talos', 11:44:20 INFO - 'log_to_console': True, 11:44:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:44:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:44:20 INFO - 'opt_config_files': (), 11:44:20 INFO - 'pip_index': False, 11:44:20 INFO - 'suite': 'dromaeojs-e10s', 11:44:20 INFO - 'system_bits': '32', 11:44:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:20 INFO - 'title': 'talos-linux64-ix-034', 11:44:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:20 INFO - 'use_talos_json': True, 11:44:20 INFO - 'verify': 'False', 11:44:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:20 INFO - 'work_dir': 'build'} 11:44:20 INFO - [mozharness: 2017-09-20 18:44:20.097504Z] Running clobber step. 11:44:20 INFO - Running pre-action listener: _resource_record_pre_action 11:44:20 INFO - Running main action method: clobber 11:44:20 INFO - rmtree: /builds/slave/test/build 11:44:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:21 INFO - Running post-action listener: _resource_record_post_action 11:44:21 INFO - [mozharness: 2017-09-20 18:44:21.615953Z] Finished clobber step (success) 11:44:21 INFO - [mozharness: 2017-09-20 18:44:21.616051Z] Running read-buildbot-config step. 11:44:21 INFO - Running pre-action listener: _resource_record_pre_action 11:44:21 INFO - Running main action method: read_buildbot_config 11:44:21 INFO - Using buildbot properties: 11:44:21 INFO - { 11:44:21 INFO - "project": "", 11:44:21 INFO - "product": "firefox", 11:44:21 INFO - "who": "ffxbld@noreply.mozilla.org", 11:44:21 INFO - "installer_path": "public/build/target.tar.bz2", 11:44:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:44:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:44:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:44:21 INFO - "stage_platform": "linux64-pgo", 11:44:21 INFO - "basedir": "/builds/slave/test", 11:44:21 INFO - "buildnumber": 185, 11:44:21 INFO - "platform": "ubuntu64_hw", 11:44:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:44:21 INFO - "slavebuilddir": "test", 11:44:21 INFO - "taskId": "ddVhJmdVT5auun303nALVg", 11:44:21 INFO - "branch": "mozilla-central", 11:44:21 INFO - "script_repo_revision": "production", 11:44:21 INFO - "revision": "7b5664b73b5bc700ee5c4befb10cdce2d9cff47e", 11:44:21 INFO - "slavename": "talos-linux64-ix-034", 11:44:21 INFO - "repo_path": "mozilla-central" 11:44:21 INFO - } 11:44:21 INFO - Finding installer, test and symbols from parent task. 11:44:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ddVhJmdVT5auun303nALVg'}, attempt #1 11:44:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ddVhJmdVT5auun303nALVg'}, attempt #1 11:44:22 INFO - Task dependencies: aIA_GDTzSB6yAt1pcYj2gA 11:44:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA'}, attempt #1 11:44:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json 11:44:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip 11:44:23 INFO - Running post-action listener: _resource_record_post_action 11:44:23 INFO - [mozharness: 2017-09-20 18:44:23.056639Z] Finished read-buildbot-config step (success) 11:44:23 INFO - [mozharness: 2017-09-20 18:44:23.056856Z] Running download-and-extract step. 11:44:23 INFO - Running pre-action listener: _resource_record_pre_action 11:44:23 INFO - Running main action method: download_and_extract 11:44:23 INFO - mkdir: /builds/slave/test/build/tests 11:44:23 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')]} 11:44:23 INFO - trying https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json 11:44:23 INFO - Downloading https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:44:23 INFO - Downloaded 989 bytes. 11:44:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:44:23 INFO - Using the following test package requirements: 11:44:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:44:23 INFO - u'common': [u'target.common.tests.zip'], 11:44:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:44:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:44:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:44:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:44:23 INFO - u'mozbase': [u'target.common.tests.zip'], 11:44:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:44:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:44:23 INFO - u'web-platform': [u'target.common.tests.zip', 11:44:23 INFO - u'target.web-platform.tests.tar.gz'], 11:44:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:44:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip 11:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.common.tests.zip into memory 11:44:25 INFO - Content-Length response header: 55323916 11:44:25 INFO - Bytes received: 55323916 11:44:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip 11:44:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:44:36 INFO - Fetch https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.talos.tests.zip into memory 11:44:37 INFO - Content-Length response header: 14508893 11:44:37 INFO - Bytes received: 14508893 11:44:37 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')]} 11:44:37 INFO - trying https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:37 INFO - Downloading https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:44:41 INFO - Downloaded 62280301 bytes. 11:44:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:41 INFO - mkdir: /builds/slave/test/properties 11:44:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:41 INFO - Contents: 11:44:41 INFO - build_url:https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 11:44:41 INFO - Running post-action listener: _resource_record_post_action 11:44:41 INFO - Running post-action listener: find_tests_for_verification 11:44:41 INFO - Running post-action listener: set_extra_try_arguments 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.410483Z] Finished download-and-extract step (success) 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.410582Z] Running populate-webroot step. 11:44:41 INFO - Running pre-action listener: _resource_record_pre_action 11:44:41 INFO - Running main action method: populate_webroot 11:44:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tresize', 11:44:41 INFO - 'tcanvasmark']}, 11:44:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['dromaeo_css', 11:44:41 INFO - 'kraken']}, 11:44:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['damp', 'tps']}, 11:44:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['damp', 'tps']}, 11:44:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['dromaeo_dom']}, 11:44:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:44:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['basic_compositor_video', 11:44:41 INFO - 'glvideo']}, 11:44:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:44:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['ts_paint_webext', 11:44:41 INFO - 'tp5o_webext']}, 11:44:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:41 INFO - 'ts_paint', 11:44:41 INFO - 'tpaint', 11:44:41 INFO - 'sessionrestore', 11:44:41 INFO - 'sessionrestore_many_windows', 11:44:41 INFO - 'sessionrestore_no_auto_restore', 11:44:41 INFO - 'tabpaint']}, 11:44:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['a11yr', 11:44:41 INFO - 'ts_paint', 11:44:41 INFO - 'tpaint', 11:44:41 INFO - 'sessionrestore', 11:44:41 INFO - 'sessionrestore_many_windows', 11:44:41 INFO - 'sessionrestore_no_auto_restore', 11:44:41 INFO - 'tabpaint']}, 11:44:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:44:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:44:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['perf_reftest_singletons']}, 11:44:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['bloom_basic']}, 11:44:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:41 INFO - 'tsvgr_opacity', 11:44:41 INFO - 'tart', 11:44:41 INFO - 'tscrollx', 11:44:41 INFO - 'tsvg_static']}, 11:44:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tsvgx', 11:44:41 INFO - 'tsvgr_opacity', 11:44:41 INFO - 'tart', 11:44:41 INFO - 'tscrollx', 11:44:41 INFO - 'tsvg_static']}, 11:44:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:44:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo'], 11:44:41 INFO - 'tests': ['tp5o']}, 11:44:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:41 INFO - 'talos_options': ['--mitmproxy', 11:44:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:41 INFO - '--firstNonBlankPaint'], 11:44:41 INFO - 'tests': ['tp6_google', 11:44:41 INFO - 'tp6_youtube', 11:44:41 INFO - 'tp6_amazon', 11:44:41 INFO - 'tp6_facebook']}, 11:44:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo', 11:44:41 INFO - '--mitmproxy', 11:44:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:41 INFO - '--firstNonBlankPaint'], 11:44:41 INFO - 'tests': ['tp6_google', 11:44:41 INFO - 'tp6_youtube', 11:44:41 INFO - 'tp6_amazon', 11:44:41 INFO - 'tp6_facebook']}, 11:44:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:44:41 INFO - 'talos_options': ['--stylo-threads=1', 11:44:41 INFO - '--mitmproxy', 11:44:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:44:41 INFO - '--firstNonBlankPaint'], 11:44:41 INFO - 'tests': ['tp6_google', 11:44:41 INFO - 'tp6_youtube', 11:44:41 INFO - 'tp6_amazon', 11:44:41 INFO - 'tp6_facebook']}, 11:44:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--xperf_path', 11:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:41 INFO - 'tests': ['tp5n']}, 11:44:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:44:41 INFO - 'talos_options': ['--disable-stylo', 11:44:41 INFO - '--xperf_path', 11:44:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:41 INFO - 'tests': ['tp5n']}}} 11:44:41 INFO - Running post-action listener: _resource_record_post_action 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.433120Z] Finished populate-webroot step (success) 11:44:41 INFO - [mozharness: 2017-09-20 18:44:41.433210Z] Running create-virtualenv step. 11:44:41 INFO - Running pre-action listener: _resource_record_pre_action 11:44:41 INFO - Running main action method: create_virtualenv 11:44:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:44:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:44:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:44:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:42 INFO - Installing pip...............done. 11:44:42 INFO - Return code: 0 11:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:44:42 INFO - Reading from file tmpfile_stdout 11:44:42 INFO - Output received: 11:44:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:44:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:42 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')]} 11:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:42 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')]} 11:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:42 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:42 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 11:44:42 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 11:44:42 INFO - Using env: {'DISPLAY': ':0', 11:44:42 INFO - 'HOME': '/home/cltbld', 11:44:42 INFO - 'LANG': 'en_US.UTF-8', 11:44:42 INFO - 'LANGUAGE': 'en_US:en', 11:44:42 INFO - 'LOGNAME': 'cltbld', 11:44:42 INFO - 'MAIL': '/var/mail/cltbld', 11:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:42 INFO - 'MOZ_NO_REMOTE': '1', 11:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:42 INFO - 'NO_EM_RESTART': '1', 11:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:42 INFO - 'PWD': '/builds/slave/test', 11:44:42 INFO - 'SHELL': '/bin/bash', 11:44:42 INFO - 'SHLVL': '1', 11:44:42 INFO - 'TERM': 'linux', 11:44:42 INFO - 'TMOUT': '86400', 11:44:42 INFO - 'USER': 'cltbld', 11:44:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:42 INFO - '_': '/tools/buildbot/bin/python'} 11:44:43 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:44:43 INFO - Downloading/unpacking pip>=1.5 11:44:43 INFO - Running setup.py egg_info for package pip 11:44:43 INFO - warning: no files found matching 'pip/cacert.pem' 11:44:43 INFO - warning: no files found matching '*.html' under directory 'docs' 11:44:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:44:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:44:43 INFO - Installing collected packages: pip 11:44:43 INFO - Found existing installation: pip 1.1 11:44:43 INFO - Uninstalling pip: 11:44:43 INFO - Successfully uninstalled pip 11:44:43 INFO - Running setup.py install for pip 11:44:43 INFO - warning: no files found matching 'pip/cacert.pem' 11:44:43 INFO - warning: no files found matching '*.html' under directory 'docs' 11:44:43 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:44:43 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:44:43 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:44:43 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:44:43 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:44:43 INFO - Successfully installed pip 11:44:43 INFO - Cleaning up... 11:44:43 INFO - Return code: 0 11:44:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44:43 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')]} 11:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:43 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')]} 11:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:43 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:43 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 11:44:43 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 11:44:43 INFO - Using env: {'DISPLAY': ':0', 11:44:43 INFO - 'HOME': '/home/cltbld', 11:44:43 INFO - 'LANG': 'en_US.UTF-8', 11:44:43 INFO - 'LANGUAGE': 'en_US:en', 11:44:43 INFO - 'LOGNAME': 'cltbld', 11:44:43 INFO - 'MAIL': '/var/mail/cltbld', 11:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:43 INFO - 'MOZ_NO_REMOTE': '1', 11:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:43 INFO - 'NO_EM_RESTART': '1', 11:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:43 INFO - 'PWD': '/builds/slave/test', 11:44:43 INFO - 'SHELL': '/bin/bash', 11:44:43 INFO - 'SHLVL': '1', 11:44:43 INFO - 'TERM': 'linux', 11:44:43 INFO - 'TMOUT': '86400', 11:44:43 INFO - 'USER': 'cltbld', 11:44:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:43 INFO - '_': '/tools/buildbot/bin/python'} 11:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:43 INFO - Downloading/unpacking psutil>=3.1.1 11:44:43 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 11:44:43 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 11:44:43 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 11:44:43 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 11:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:45 INFO - Installing collected packages: psutil 11:44:45 INFO - Running setup.py install for psutil 11:44:45 INFO - building 'psutil._psutil_linux' extension 11:44:45 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 11:44:45 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 11:44:45 INFO - building 'psutil._psutil_posix' extension 11:44:45 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 11:44:45 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 11:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:45 INFO - Successfully installed psutil 11:44:45 INFO - Cleaning up... 11:44:45 INFO - Return code: 0 11:44:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44:45 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')]} 11:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:45 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')]} 11:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:45 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:45 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 11:44:45 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 11:44:45 INFO - Using env: {'DISPLAY': ':0', 11:44:45 INFO - 'HOME': '/home/cltbld', 11:44:45 INFO - 'LANG': 'en_US.UTF-8', 11:44:45 INFO - 'LANGUAGE': 'en_US:en', 11:44:45 INFO - 'LOGNAME': 'cltbld', 11:44:45 INFO - 'MAIL': '/var/mail/cltbld', 11:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:45 INFO - 'MOZ_NO_REMOTE': '1', 11:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:45 INFO - 'NO_EM_RESTART': '1', 11:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:45 INFO - 'PWD': '/builds/slave/test', 11:44:45 INFO - 'SHELL': '/bin/bash', 11:44:45 INFO - 'SHLVL': '1', 11:44:45 INFO - 'TERM': 'linux', 11:44:45 INFO - 'TMOUT': '86400', 11:44:45 INFO - 'USER': 'cltbld', 11:44:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:45 INFO - '_': '/tools/buildbot/bin/python'} 11:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:45 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 11:44:45 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 11:44:45 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 11:44:45 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 11:44:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:47 INFO - Installing collected packages: mozsystemmonitor 11:44:47 INFO - Running setup.py install for mozsystemmonitor 11:44:47 INFO - Successfully installed mozsystemmonitor 11:44:47 INFO - Cleaning up... 11:44:47 INFO - Return code: 0 11:44:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:44:47 INFO - Using env: {'DISPLAY': ':0', 11:44:47 INFO - 'HOME': '/home/cltbld', 11:44:47 INFO - 'LANG': 'en_US.UTF-8', 11:44:47 INFO - 'LANGUAGE': 'en_US:en', 11:44:47 INFO - 'LOGNAME': 'cltbld', 11:44:47 INFO - 'MAIL': '/var/mail/cltbld', 11:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:47 INFO - 'MOZ_NO_REMOTE': '1', 11:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:47 INFO - 'NO_EM_RESTART': '1', 11:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:47 INFO - 'PWD': '/builds/slave/test', 11:44:47 INFO - 'SHELL': '/bin/bash', 11:44:47 INFO - 'SHLVL': '1', 11:44:47 INFO - 'TERM': 'linux', 11:44:47 INFO - 'TMOUT': '86400', 11:44:47 INFO - 'USER': 'cltbld', 11:44:47 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:47 INFO - '_': '/tools/buildbot/bin/python'} 11:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:47 INFO - Downloading/unpacking jsonschema==2.5.1 11:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:44:48 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 11:44:48 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 11:44:48 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 11:44:48 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 11:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:48 INFO - warning: no files found matching '*.txt' 11:44:48 INFO - no previously-included directories found matching 'build' 11:44:48 INFO - no previously-included directories found matching 'dist' 11:44:48 INFO - no previously-included directories found matching '.git*' 11:44:48 INFO - Installing collected packages: jsonschema, functools32 11:44:48 INFO - Running setup.py install for functools32 11:44:49 INFO - warning: no files found matching '*.txt' 11:44:49 INFO - no previously-included directories found matching 'build' 11:44:49 INFO - no previously-included directories found matching 'dist' 11:44:49 INFO - no previously-included directories found matching '.git*' 11:44:49 INFO - Successfully installed jsonschema functools32 11:44:49 INFO - Cleaning up... 11:44:49 INFO - Return code: 0 11:44:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:44:49 INFO - Using env: {'DISPLAY': ':0', 11:44:49 INFO - 'HOME': '/home/cltbld', 11:44:49 INFO - 'LANG': 'en_US.UTF-8', 11:44:49 INFO - 'LANGUAGE': 'en_US:en', 11:44:49 INFO - 'LOGNAME': 'cltbld', 11:44:49 INFO - 'MAIL': '/var/mail/cltbld', 11:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:49 INFO - 'MOZ_NO_REMOTE': '1', 11:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:49 INFO - 'NO_EM_RESTART': '1', 11:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:49 INFO - 'PWD': '/builds/slave/test', 11:44:49 INFO - 'SHELL': '/bin/bash', 11:44:49 INFO - 'SHLVL': '1', 11:44:49 INFO - 'TERM': 'linux', 11:44:49 INFO - 'TMOUT': '86400', 11:44:49 INFO - 'USER': 'cltbld', 11:44:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:49 INFO - '_': '/tools/buildbot/bin/python'} 11:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:49 INFO - Cleaning up... 11:44:49 INFO - Return code: 0 11:44:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:44:49 INFO - Using env: {'DISPLAY': ':0', 11:44:49 INFO - 'HOME': '/home/cltbld', 11:44:49 INFO - 'LANG': 'en_US.UTF-8', 11:44:49 INFO - 'LANGUAGE': 'en_US:en', 11:44:49 INFO - 'LOGNAME': 'cltbld', 11:44:49 INFO - 'MAIL': '/var/mail/cltbld', 11:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:49 INFO - 'MOZ_NO_REMOTE': '1', 11:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:49 INFO - 'NO_EM_RESTART': '1', 11:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:49 INFO - 'PWD': '/builds/slave/test', 11:44:49 INFO - 'SHELL': '/bin/bash', 11:44:49 INFO - 'SHLVL': '1', 11:44:49 INFO - 'TERM': 'linux', 11:44:49 INFO - 'TMOUT': '86400', 11:44:49 INFO - 'USER': 'cltbld', 11:44:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:49 INFO - '_': '/tools/buildbot/bin/python'} 11:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:50 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 11:44:50 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 11:44:50 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 11:44:50 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 11:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:51 INFO - Downloading docopt-0.6.1.tar.gz 11:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:53 INFO - Running setup.py install for blobuploader 11:44:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:53 INFO - Running setup.py install for requests 11:44:53 INFO - Running setup.py install for docopt 11:44:53 INFO - Successfully installed blobuploader requests docopt 11:44:53 INFO - Cleaning up... 11:44:53 INFO - Return code: 0 11:44:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:53 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:53 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 11:44:53 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 11:44:53 INFO - Using env: {'DISPLAY': ':0', 11:44:53 INFO - 'HOME': '/home/cltbld', 11:44:53 INFO - 'LANG': 'en_US.UTF-8', 11:44:53 INFO - 'LANGUAGE': 'en_US:en', 11:44:53 INFO - 'LOGNAME': 'cltbld', 11:44:53 INFO - 'MAIL': '/var/mail/cltbld', 11:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:53 INFO - 'MOZ_NO_REMOTE': '1', 11:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:53 INFO - 'NO_EM_RESTART': '1', 11:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:53 INFO - 'PWD': '/builds/slave/test', 11:44:53 INFO - 'SHELL': '/bin/bash', 11:44:53 INFO - 'SHLVL': '1', 11:44:53 INFO - 'TERM': 'linux', 11:44:53 INFO - 'TMOUT': '86400', 11:44:53 INFO - 'USER': 'cltbld', 11:44:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:53 INFO - '_': '/tools/buildbot/bin/python'} 11:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:53 INFO - Running setup.py (path:/tmp/pip-rVXDdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:53 INFO - Running setup.py (path:/tmp/pip-eeKGAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:53 INFO - Running setup.py (path:/tmp/pip-TZviha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:54 INFO - Running setup.py (path:/tmp/pip-WBVBqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:54 INFO - Running setup.py (path:/tmp/pip-wRF_et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:54 INFO - Running setup.py (path:/tmp/pip-9OkLiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:54 INFO - Running setup.py (path:/tmp/pip-X99XMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:54 INFO - Running setup.py (path:/tmp/pip-iAy_AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:54 INFO - Running setup.py (path:/tmp/pip-AOsU2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:54 INFO - Running setup.py (path:/tmp/pip-QDebG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:54 INFO - Running setup.py (path:/tmp/pip-RtPzIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:54 INFO - Running setup.py (path:/tmp/pip-GMP8A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:54 INFO - Running setup.py (path:/tmp/pip-IFAauy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:54 INFO - Running setup.py (path:/tmp/pip-EqKDtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:54 INFO - Running setup.py (path:/tmp/pip-IKC7_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:54 INFO - Running setup.py (path:/tmp/pip-2SXcYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:54 INFO - Running setup.py (path:/tmp/pip-lDLaV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:55 INFO - Running setup.py install for manifestparser 11:44:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozcrash 11:44:55 INFO - Running setup.py install for mozdebug 11:44:55 INFO - Running setup.py install for mozdevice 11:44:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozfile 11:44:55 INFO - Running setup.py install for mozhttpd 11:44:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozinfo 11:44:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozInstall 11:44:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:44:55 INFO - Running setup.py install for mozleak 11:44:55 INFO - Running setup.py install for mozlog 11:44:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Running setup.py install for moznetwork 11:44:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Running setup.py install for mozprocess 11:44:56 INFO - Running setup.py install for mozprofile 11:44:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Running setup.py install for mozrunner 11:44:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Running setup.py install for mozscreenshot 11:44:56 INFO - Running setup.py install for moztest 11:44:56 INFO - Running setup.py install for mozversion 11:44:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:44:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:44:56 INFO - Cleaning up... 11:44:56 INFO - Return code: 0 11:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44: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')]} 11:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:56 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:56 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 11:44:56 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 11:44:56 INFO - Using env: {'DISPLAY': ':0', 11:44:56 INFO - 'HOME': '/home/cltbld', 11:44:56 INFO - 'LANG': 'en_US.UTF-8', 11:44:56 INFO - 'LANGUAGE': 'en_US:en', 11:44:56 INFO - 'LOGNAME': 'cltbld', 11:44:56 INFO - 'MAIL': '/var/mail/cltbld', 11:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:56 INFO - 'MOZ_NO_REMOTE': '1', 11:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:56 INFO - 'NO_EM_RESTART': '1', 11:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:56 INFO - 'PWD': '/builds/slave/test', 11:44:56 INFO - 'SHELL': '/bin/bash', 11:44:56 INFO - 'SHLVL': '1', 11:44:56 INFO - 'TERM': 'linux', 11:44:56 INFO - 'TMOUT': '86400', 11:44:56 INFO - 'USER': 'cltbld', 11:44:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:56 INFO - '_': '/tools/buildbot/bin/python'} 11:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:57 INFO - Running setup.py (path:/tmp/pip-8W3o_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:57 INFO - Running setup.py (path:/tmp/pip-lf0GHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:57 INFO - Running setup.py (path:/tmp/pip-JIXLix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:57 INFO - Running setup.py (path:/tmp/pip-HQwB2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:57 INFO - Running setup.py (path:/tmp/pip-fgKK8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:57 INFO - Running setup.py (path:/tmp/pip-sLtxhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:57 INFO - Running setup.py (path:/tmp/pip-pEWXgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:57 INFO - Running setup.py (path:/tmp/pip-TkazJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:57 INFO - Running setup.py (path:/tmp/pip-ssIwhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:57 INFO - Running setup.py (path:/tmp/pip-hBACYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:57 INFO - Running setup.py (path:/tmp/pip-H1hsIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:57 INFO - Running setup.py (path:/tmp/pip-9GTwNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:57 INFO - Running setup.py (path:/tmp/pip-dPOQs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:57 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)) 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:57 INFO - Running setup.py (path:/tmp/pip-cklSI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:58 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)) 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:58 INFO - Running setup.py (path:/tmp/pip-F7QPaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:58 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)) 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:58 INFO - Running setup.py (path:/tmp/pip-FCUkUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:58 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)) 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:58 INFO - Running setup.py (path:/tmp/pip-4sXiKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:58 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)) 11:44:58 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)) 11:44:58 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)) 11:44:58 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)) 11:44:58 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)) 11:44:58 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)) 11:44:58 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)) 11:44:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:59 INFO - Downloading blessings-1.6.tar.gz 11:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:44:59 INFO - Installing collected packages: blessings 11:44:59 INFO - Running setup.py install for blessings 11:44:59 INFO - Successfully installed blessings 11:44:59 INFO - Cleaning up... 11:44:59 INFO - Return code: 0 11:44:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:44:59 INFO - Reading from file tmpfile_stdout 11:44:59 INFO - Current package versions: 11:44:59 INFO - argparse == 1.2.1 11:44:59 INFO - blessings == 1.6 11:44:59 INFO - blobuploader == 1.2.4 11:44:59 INFO - docopt == 0.6.1 11:44:59 INFO - functools32 == 3.2.3-2 11:44:59 INFO - jsonschema == 2.5.1 11:44:59 INFO - manifestparser == 1.1 11:44:59 INFO - mozInstall == 1.13 11:44:59 INFO - mozcrash == 1.0 11:44:59 INFO - mozdebug == 0.1 11:44:59 INFO - mozdevice == 0.51 11:44:59 INFO - mozfile == 1.2 11:44:59 INFO - mozhttpd == 0.7 11:44:59 INFO - mozinfo == 0.10 11:44:59 INFO - mozleak == 0.1 11:44:59 INFO - mozlog == 3.5 11:44:59 INFO - moznetwork == 0.27 11:44:59 INFO - mozprocess == 0.25 11:44:59 INFO - mozprofile == 0.28 11:44:59 INFO - mozrunner == 6.13 11:44:59 INFO - mozscreenshot == 0.1 11:44:59 INFO - mozsystemmonitor == 0.3 11:44:59 INFO - moztest == 0.8 11:44:59 INFO - mozversion == 1.4 11:44:59 INFO - psutil == 3.1.1 11:44:59 INFO - requests == 1.2.3 11:44:59 INFO - wsgiref == 0.1.2 11:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44: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')]} 11:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:59 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 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:44:59 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 11:44:59 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 11:44:59 INFO - Using env: {'DISPLAY': ':0', 11:44:59 INFO - 'HOME': '/home/cltbld', 11:44:59 INFO - 'LANG': 'en_US.UTF-8', 11:44:59 INFO - 'LANGUAGE': 'en_US:en', 11:44:59 INFO - 'LOGNAME': 'cltbld', 11:44:59 INFO - 'MAIL': '/var/mail/cltbld', 11:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:59 INFO - 'MOZ_NO_REMOTE': '1', 11:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:59 INFO - 'NO_EM_RESTART': '1', 11:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:59 INFO - 'PWD': '/builds/slave/test', 11:44:59 INFO - 'SHELL': '/bin/bash', 11:44:59 INFO - 'SHLVL': '1', 11:44:59 INFO - 'TERM': 'linux', 11:44:59 INFO - 'TMOUT': '86400', 11:44:59 INFO - 'USER': 'cltbld', 11:44:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:59 INFO - '_': '/tools/buildbot/bin/python'} 11:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:44:59 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)) 11:45:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:45: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 11:45: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 11:45: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 11:45: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 11:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:45:01 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)) 11:45:01 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)) 11:45:01 INFO - Installing collected packages: simplejson 11:45:01 INFO - Running setup.py install for simplejson 11:45:01 INFO - building 'simplejson._speedups' extension 11:45:01 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 11:45:02 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 11:45:02 INFO - Successfully installed simplejson 11:45:02 INFO - Cleaning up... 11:45:02 INFO - Return code: 0 11:45:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45: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')]} 11:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45: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')]} 11:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf101f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', '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 11:45: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', 'jsonschema'] in /builds/slave/test/build 11:45: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 jsonschema 11:45:02 INFO - Using env: {'DISPLAY': ':0', 11:45:02 INFO - 'HOME': '/home/cltbld', 11:45:02 INFO - 'LANG': 'en_US.UTF-8', 11:45:02 INFO - 'LANGUAGE': 'en_US:en', 11:45:02 INFO - 'LOGNAME': 'cltbld', 11:45:02 INFO - 'MAIL': '/var/mail/cltbld', 11:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:02 INFO - 'MOZ_NO_REMOTE': '1', 11:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:02 INFO - 'NO_EM_RESTART': '1', 11:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:02 INFO - 'PWD': '/builds/slave/test', 11:45:02 INFO - 'SHELL': '/bin/bash', 11:45:02 INFO - 'SHLVL': '1', 11:45:02 INFO - 'TERM': 'linux', 11:45:02 INFO - 'TMOUT': '86400', 11:45:02 INFO - 'USER': 'cltbld', 11:45:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:02 INFO - '_': '/tools/buildbot/bin/python'} 11:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:02 INFO - Cleaning up... 11:45:02 INFO - Return code: 0 11:45:02 INFO - Running post-action listener: _resource_record_post_action 11:45:02 INFO - Running post-action listener: _start_resource_monitoring 11:45:02 INFO - Starting resource monitoring. 11:45:02 INFO - [mozharness: 2017-09-20 18:45:02.535494Z] Finished create-virtualenv step (success) 11:45:02 INFO - [mozharness: 2017-09-20 18:45:02.535967Z] Running install step. 11:45:02 INFO - Running pre-action listener: _resource_record_pre_action 11:45:02 INFO - Running main action method: install 11:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:02 INFO - Reading from file tmpfile_stdout 11:45:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:02 INFO - Reading from file tmpfile_stdout 11:45:02 INFO - Output received: 11:45:02 INFO - Usage: mozinstall [options] installer 11:45:02 INFO - Options: 11:45:02 INFO - -h, --help show this help message and exit 11:45:02 INFO - -d DEST, --destination=DEST 11:45:02 INFO - Directory to install application into. [default: 11:45:02 INFO - "/builds/slave/test"] 11:45:02 INFO - --app=APP Application being installed. [default: firefox] 11:45:02 INFO - mkdir: /builds/slave/test/build/application 11:45:02 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'] 11:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:45:20 INFO - Reading from file tmpfile_stdout 11:45:20 INFO - Output received: 11:45:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:45:20 INFO - Running post-action listener: _resource_record_post_action 11:45:20 INFO - [mozharness: 2017-09-20 18:45:20.484467Z] Finished install step (success) 11:45:20 INFO - [mozharness: 2017-09-20 18:45:20.484721Z] Running setup-mitmproxy step. 11:45:20 INFO - Running pre-action listener: _resource_record_pre_action 11:45:20 INFO - Running main action method: setup_mitmproxy 11:45:20 INFO - Skipping: mitmproxy is not required 11:45:20 INFO - Running post-action listener: _resource_record_post_action 11:45:20 INFO - [mozharness: 2017-09-20 18:45:20.485851Z] Finished setup-mitmproxy step (success) 11:45:20 INFO - [mozharness: 2017-09-20 18:45:20.486137Z] Running run-tests step. 11:45:20 INFO - Running pre-action listener: _resource_record_pre_action 11:45:20 INFO - Running pre-action listener: _set_gcov_prefix 11:45:20 INFO - Running main action method: run_tests 11:45:20 WARNING - Try message not found. 11:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:20 INFO - Python 2.7.3 11:45:20 INFO - Return code: 0 11:45:20 INFO - grabbing minidump binary from tooltool 11:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:20 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 0x1280090>, '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 0x1280d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:20 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 11:45:20 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 11:45:20 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 11:45:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:20 INFO - Return code: 0 11:45:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:45:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:20 INFO - ENV: RUST_BACKTRACE is now full 11:45:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:45:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:20 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/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:45:20 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/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 11:45:20 INFO - Using env: {'DISPLAY': ':0', 11:45:20 INFO - 'HOME': '/home/cltbld', 11:45:20 INFO - 'LANG': 'en_US.UTF-8', 11:45:20 INFO - 'LANGUAGE': 'en_US:en', 11:45:20 INFO - 'LOGNAME': 'cltbld', 11:45:20 INFO - 'MAIL': '/var/mail/cltbld', 11:45:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:20 INFO - 'MOZ_NO_REMOTE': '1', 11:45:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:20 INFO - 'NO_EM_RESTART': '1', 11:45:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:20 INFO - 'PWD': '/builds/slave/test', 11:45:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:20 INFO - 'RUST_BACKTRACE': 'full', 11:45:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:20 INFO - 'SHELL': '/bin/bash', 11:45:20 INFO - 'SHLVL': '1', 11:45:20 INFO - 'TERM': 'linux', 11:45:20 INFO - 'TMOUT': '86400', 11:45:20 INFO - 'USER': 'cltbld', 11:45:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:20 INFO - '_': '/tools/buildbot/bin/python'} 11:45:20 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/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 11:45:20 INFO - mozversion application_buildid: 20170920172637 11:45:20 INFO - mozversion application_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:45:20 INFO - mozversion application_display_name: Nightly 11:45:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:20 INFO - mozversion application_name: Firefox 11:45:20 INFO - mozversion application_remotingname: firefox 11:45:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:45:20 INFO - mozversion application_vendor: Mozilla 11:45:20 INFO - mozversion application_version: 57.0a1 11:45:20 INFO - mozversion platform_buildid: 20170920172637 11:45:20 INFO - mozversion platform_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:45:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:45:20 INFO - mozversion platform_version: 57.0a1 11:45:20 INFO - using testdate: 1505933120 11:45:20 INFO - actual date: 1505933120 11:45:20 INFO - starting webserver on 'localhost:38127' 11:45:20 INFO - SUITE-START | Running 2 tests 11:45:20 INFO - TEST-START | dromaeo_css 11:45:20 INFO - Initialising browser for dromaeo_css test... 11:45:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38127/getInfo.html -profile /tmp/tmpJnxiOu/profile 11:45:20 INFO - TEST-INFO | started process 15504 (/builds/slave/test/build/application/firefox/firefox http://localhost:38127/getInfo.html) 11:45:26 INFO - TEST-INFO | 15504: exit 0 11:45:26 INFO - Browser initialized. 11:45:26 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:26 INFO - Using env: {'DISPLAY': ':0', 11:45:26 INFO - 'HOME': '/home/cltbld', 11:45:26 INFO - 'JSGC_DISABLE_POISONING': '1', 11:45:26 INFO - 'LANG': 'en_US.UTF-8', 11:45:26 INFO - 'LANGUAGE': 'en_US:en', 11:45:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:45:26 INFO - 'LOGNAME': 'cltbld', 11:45:26 INFO - 'MAIL': '/var/mail/cltbld', 11:45:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:26 INFO - 'MOZ_CRASHREPORTER': '1', 11:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:45:26 INFO - 'MOZ_NO_REMOTE': '1', 11:45:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:26 INFO - 'NO_EM_RESTART': '1', 11:45:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:26 INFO - 'PWD': '/builds/slave/test', 11:45:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:26 INFO - 'RUST_BACKTRACE': 'full', 11:45:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:26 INFO - 'SHELL': '/bin/bash', 11:45:26 INFO - 'SHLVL': '1', 11:45:26 INFO - 'TERM': 'linux', 11:45:26 INFO - 'TMOUT': '86400', 11:45:26 INFO - 'USER': 'cltbld', 11:45:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 11:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:26 INFO - '_': '/tools/buildbot/bin/python'} 11:45:26 INFO - TEST-INFO | started process 15742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJnxiOu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:27 INFO - PID 15742 | 11:45:27 INFO - PID 15742 | (/builds/slave/test/build/application/firefox/firefox:15791): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:45:27 INFO - PID 15742 | 11:45:37 INFO - PID 15742 | RSS: Main: 147353600 11:45:37 INFO - PID 15742 | 11:48:35 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38127/tests/dromaeo/cssquery-ext.html) 11:48:36 INFO - PID 15742 | RSS: Main: 148033536 11:48:36 INFO - PID 15742 | 11:51:37 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-ext.html (next: http://localhost:38127/tests/dromaeo/cssquery-jquery.html) 11:51:38 INFO - PID 15742 | RSS: Main: 147943424 11:51:38 INFO - PID 15742 | 11:54:40 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38127/tests/dromaeo/cssquery-mootools.html) 11:54:40 INFO - PID 15742 | RSS: Main: 149938176 11:54:40 INFO - PID 15742 | 11:57:42 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38127/tests/dromaeo/cssquery-prototype.html) 11:57:42 INFO - PID 15742 | RSS: Main: 148234240 11:57:42 INFO - PID 15742 | 12:00:45 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38127/tests/dromaeo/cssquery-yui.html) 12:00:46 INFO - PID 15742 | RSS: Main: 149880832 12:00:46 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | Cycle 1(1): loaded http://localhost:38127/tests/dromaeo/cssquery-yui.html (next: http://localhost:38127/tests/dromaeo/cssquery-dojo.html) 12:03:48 INFO - PID 15742 | RSS: Main: 152985600 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | __start_tp_report 12:03:48 INFO - PID 15742 | _x_x_mozilla_page_load 12:03:48 INFO - PID 15742 | _x_x_mozilla_page_load_details 12:03:48 INFO - PID 15742 | |i|pagename|runs| 12:03:48 INFO - PID 15742 | |0;dojo.html;3775.509183806105;3782.5082739243903;3826.3112639724854;3828.6171382861735;3849.095462566297;6073.240844894388;6185.134081228632;6232.719527621257;6257.061440783879;6309.747610095596;6202.4417802397775;6204.78283260086;6266.060090986354;6292.402221788934;6313.526485513594;5572.637778544382;5598;5617.9438205617935;5633;5673.773049078032;5717.628354156987;5718.228039214715;5728.283964504437;5728.742206600713;5778.7977420790285;5663.8584035399235;5672.376038635747;5697.401772813857;5780.710964451781;5781.739821708034;5469.480399362054;5564.443555644443;5581.6930068846195;5669.433056694339;5695.629784064023;5602.187682786014;5605.439456054402;5691.4877661010705;5692.0608099663505;5696.6866822324755;6126.540509461808;6153.692315384257;6206.689665516751;6259.405356491126;6353;6709.899351509731;6721.395074443323;6747.021681856152;6765.052892594991;6795.082663840368;6872.518923675345;6915.89626155608;6916.827079323007;6925.930740692579;6936.306369363074;6324.33594472583;6337.524685648595;6406.327335629739;6409.7436102555375;6434.163558737381;6955.513114081966;6960.895586566206;6967.54710943787;6980.127484064492;7065.116860392451;6577.736890524421;6596.703148358335;6603.933960660428;6652.467802575782;6807.047013418125;6747.190337159573;6760.357766012221;6794.76218332356;6805.081314022544;6817.318268173143;6802.319768023158;6811.318868113248;6822.761203357859;6823.147106611674;6859.691313890887;6737.9663101685155;6739.191297044386;6740.83147921296;6830.829229269209;6847.349501797321;4827.565519103227;4895.069936712013;4898.657094003385;4927.901441971212;4929.926051109236;4448.688591798543;4483.641308695296;4493.505714371417;4511;4513.932291015637;6107.328193898667;6176.66028368444;6216.098665693449;6237.033259844731;6266.843328916813;6739.898901516482;6766.49251306154;6832.521723479408;6836.726530938806;6844.931550684529;6023.27720673522;6120.112583675431;6132.356102609162;6195.783147589813;6230.501559875199;5457.727113644302;5484.7531861066345;5522.889542209134;5524.917126243109;5532.917006244909;6837.3162683731225;6989.126359205099;6995.4053905417595;7011.859762804817;7025;6771.3905748482875;6779.389854912983;6876.553024053421;6885.242623311332;6887.035814985906;6786.93213067863;6889.448844092561;6898.724051038103;6924.896126558005;6979.162500499972;6753.257141714505;6754.12196414463;6758.662066896733;6761.3238676132;6774.220964588938;6772.830679233059;6779.6271205084195;6787.626680532618;6871.896921546281;6884.345987131214;6528.314526974599;6548.934510655023;6623.437007854193;6649.867002660017;6654.168228971379;6438;6502.0246962955935;6512.804615861532;6526.653322578381;6626.237982632059;6469.45009674183;6496.70764815575;6523.836904077436;6524.706388212447;6527.477801775942;6545.181852268466;6618.63597502142;6633.767818126343;6663.566868153748;6683;6303.306636269915;6373.171487706569;6405.679716014274;6409;6504.707288171949 12:03:48 INFO - PID 15742 | |1;ext.html;909.6997990663082;952.2096659772394;953.4279432340594;1001.2240513601957;1005.7686732051633;42855.571444285546;44183.55816441835;44255.11489770203;44324;44332.55667443325;41603;41634;41805.58194418055;41872.162556748845;41909.58090419095;7686.9231307686905;7758.6896524138965;7786.260305271018;7811.140774514799;7832.530048197098;7641.656125474339;7726.961365193166;7752.689892404325;7754.224577542257;7773.611319434006;8250.257476827084;8442.57787110645;8504.617292221865;8519.977602687655;8523.318134549252;8409.411341206118;8411.495310281372;8444.155584441538;8457.450265732768;8481.109483504235;8021.157778433298;8148.633311500997;8293.875591866126;8300;8309.750707478785;40452.79773601113;40813.591864081274;40818;40872.38691419631;40955;3775.6979441644603;3795.1650636859845;3811.00913762421;3835.4246862970776;3835.53973523179;33316.50025249623;33362;33383;33487;33565.6643433565;5442.91835622466;5499.807506737245;5511.53151982082;5527.419620939824;5545.889082218373;205517;209191;210601;211010;231422;53297.46702533003;54126.72936635291;54160.45839541554;54166.729166353914;54194.72902635462;57013.71493142591;57032.714836425555;57064.71467642718;57188.71405642945;57241.14138287929;14259.714805703828;14307.141571505743;14484.710305793826;14517.85482145165;14537.85462145365;10744.247902646739;10762.892371076188;10763.83854242187;10766.838497422545;10768.515416806262;15343.61640958985;15554.377824886878;15569;15574.844251557566;15627.531174064796;5855.3851845556455;6116.847078823065;6124.11200375943;6154.3845615438095;6166.445019948226;1099.9560017599206;1106.269861891148;1106.330669944688;1109.3177695717238;1123.0229700160912;25159.62260566093;25243.74756252414;25308.39832722947;25353;25423.87288063585;1155.936423496699;1184.6979020349756;1195.354508565365;1196.1746394987604;1200.0759415250209;13452.260125692985;13511.391987360592;13529;13568.457261709618;13603.863961360457;279692;280961;281156;281179;281438;57932.710336448894;58179.709101454224;58219.70890145607;58315.416845831;58332.70833645805;1495.9850401496064;1518.3698765012616;1531.7549192129206;1545.51316335354;1552.2161308539116;24992;25109.548863539665;25133;25239.11663091783;25369.74630253748;41294.55469058568;41333;41363.1727365445;41366.1726765469;41448.171036579704;236209;236785;237350;237730;238006;33435;33622.66377336195;34335.08151807024;36183.63816361908;36539.63460365362;44855.32717009182;46730;46914.53085469102;47028;47357.289640656105;33943;34121.82939085289;34407.483887741204;34931.301373972885;34952.300953980266;34007.82996085004;34354.65645343515;34523.48214776831;34592;35140;39308.80345598254;39998.80000599979;40386.798066010655;40482.595174049064;40547.391789122594;31992.520112198803;32642.347153057282;32855.50716739203;32885.67114328922;33147.834260829506;25073.749262507143;25147;25271.87364063168;25942.092026778973;26025.21924342273 12:03:48 INFO - PID 15742 | |2;jquery.html;579.9217105690733;598.2880372356892;598.6228675934161;613.1109890658545;638.3393188050368;23244.302670919857;24009.63985540216;24042.75957240427;24051.15820946265;24056.158034468797;23096.8845155774;24861.75138248617;25030.123945661904;25053.87473062637;25108.372290692743;6627.37039981201;6820.181578210597;6822.522423430361;6831.897521537181;6838.521303508756;6375.936240637604;6693.23027851796;6695.3304669533145;6861.48538859585;6876.587404755731;6642.136522252101;6656.534042617019;6668.699908504129;6670.299618540056;6672.232693240267;6495.188101487314;6600.504962127836;6642.335766423367;6643.435307998801;6644.402003819631;6271.655058971754;6321.304656487782;6327.778527751507;6327.873442531123;6328.6202827830475;30429.847850760827;30937.690623093706;30941.381172376652;30957.535636965462;31006.689933100606;2299.6895419118373;2330.4406942333885;2337.5792357375667;2341.555104530134;2344.542814151241;20757.584848302948;21338.786612133834;21707.131714731393;21805.2368167115;21944.45138871525;2546.5543529882198;2560.1679454177465;2591.1708253358934;2637.3406648337914;2638.2480992916926;138221;142745.28627356797;145472;156318.21840890837;158539;16068.312827153215;16459.25933333003;16641.334346625998;16803.327866885433;16925.576860578585;26255.343616409744;26438.735612644014;26485.205443836716;26501.469970600865;26545.867270663908;9120.543972801333;9152.8627070594;9268.7682807929;9348.672796452092;9360.297977651568;7911.446198766146;7922;7985.401094917905;7985.441019128605;8022.358211343078;9988.950055249677;10115.218314963444;10121.746956326151;10161.390316581028;10221.74445638865;2956.822590644568;2959.6448426188563;2975.4495418347674;3011.141824579984;3041.300500884809;1040.490159821682;1061.9309744866714;1062.0919114157284;1063.9734006649896;1066.1896958311584;21727.67408488874;21886.671699924515;21901.890490547445;21998.670019949714;22047.889760551094;1083.2904447586843;1092.470151976291;1097.3690128176331;1111.6665000499818;1116.9497372618252;11904.166708330507;12141.878581214252;12154.392280386122;12256;12419.254844709165;582261;590532;594383;599724;608862;128565.35717321353;129540;130482;131262;135236;1105.8120119579692;1157.1610582327912;1183.4260383713893;1199.4302706214478;1239.7148655809215;22665.2067177648;23040;23152.305430837103;23174.652380213975;23352.883235583715;60483.697581513574;60962.695186523786;62091.689541552005;63961;65568;77256.61371693105;77645.61177194078;78315;78552;79379.60310198412;16066;16245.67508649844;16354.836451635332;16441.67116657684;16462;24967.250982470556;25220.74779252184;25388.873055634605;25395.746042539336;25452.236432907044;20163;20310.492237694176;20788.792112078685;20847.791522084586;21020.369388918356;18282.268709251483;18283;18476.538086547946;18484.075796210403;18936.43190704281;20432;21093.628914120534;21101.472463188544;21136.471588210417;21405.250816221982;16334.591635209215;16337.183140843148;16434.75347869759;16437.09595972233;16482.598979086913;19592.608147837247;20223.29218477346;20628;20646.690299645215;20667 12:03:48 INFO - PID 15742 | |3;mootools.html;1348.5684580934103;1417.5463851567497;1432.992835035825;1437.2813593203398;1441.4450436581913;16786.74819877701;17459.214335354907;17489.475315740518;17497.737533937;17498;17080.48758537246;17109.743353849703;17248.31006759731;17261.654766904656;17263.30946762131;2729.113038262563;2783.304173956511;2834.829910205384;2839.3895312507807;2839.4746971810177;2732.53546897028;2779.7081306462833;2791.5393959996577;2792.0786140573664;2794.9021784237557;2724.2508310214653;2737.137801592502;2737.4935636907235;2831.3204830840655;2831.6460442444695;2767.6955534891144;2785.56823692326;2789.7489225969557;2799.70603086676;2801.495730768461;2590.8315959462575;2598.8310759800743;2608.79129669626;2629.5661215899354;2630.302969713028;16331.591710207222;16724;16740.748888766677;16755.162241887858;16762.497125086265;8164.061132969666;8483.194096560817;8487.660493580312;8488.405811593191;8494;5070.619703522214;5299.311089558333;5382.757775900055;5426.403095659474;5426.701531415771;1977.7033444983224;2051.9487012824798;2067.2764532413685;2068.431181425105;2128.7871212878745;30113.397732045454;30419.847900760575;30451.847740761375;30482.69517304843;30521.23696907573;7051.541649792747;7318.194998550155;7350.0812398449125;7399.556026638311;7460.328570428687;19575.314863979977;19577.902110489358;19598.70601940972;19604.901975490033;19639.901800490905;8287.461315014625;8424.83150337002;8446.282066024334;8451.619677114544;8458.788530286669;7443.330100291;7447.925520744831;7628.084629844454;7651.732189373345;7733.381329493627;5390.730463476889;5533.723313834373;5555.2222688823595;5596.384397716248;5643.661380317194;1592.2755146408356;1598.3287019451625;1614.6609212065598;1617.4714894424656;1642.5072478256714;801.1867954026668;914.8307563100848;928.2527565309855;935.6491315756591;956.2445667922264;9042.18620324174;9313.953430232805;9381.859272110923;9394.436333819993;9445.386049906734;1042.9061384475283;1061.3737894642197;1071.0681706914877;1079.233744041739;1079.6599071292517;5599.272094627672;5604.97197514018;5692.943070569324;5815.94184058154;5914.792982245601;23590.4102397438;23974;25146.74853251444;25711.742882570936;25730.6140407894;23652.88173559121;25205.11782087618;25235;25260.242192734248;25273.62089568658;11688.18182727201;11888.227265227733;11938.52245910154;11974.52101915931;12033.338166400757;8667.609957552051;8742.213200811957;8823.161799629024;8825.69110081144;8869.157430044394;20593.691094633894;20810.583788324453;21655.566888662455;21767.78232217721;22079.227227046977;21543.56912861765;21607.45981350479;21736.782632173476;21942.780572194075;21957.67063494081;12315.876841231473;12354.938225308815;12429.875701242872;12430.192037517532;12435.316057616918;15787.368505259661;15789;15918.9204053979;16000;16037.518874433787;12083.214591051554;12285.1400401971;12492.937535312265;12520.373981301082;12745.235285882876;11640.301581905112;11963.940180299043;12013.459394327101;12046.156769026084;12364.258144511357;10727.356358618508;11015.83476247873;11025.283356581796;11030.613928512463;11032.889671103187;7988.281054705104;8001.399895007781;8016.83966320682;8021.8395632088195;8034.558099304594;7980.760577182694;8064.556449395105;8163;8216.589170541569;8236.217559331853 12:03:48 INFO - PID 15742 | |4;prototype.html;550.9173623956406;557.8772670012598;576.437972976348;585.6808039618408;586.8503531599445;5724.141378793178;6288.402601752838;6303.716332765025;6314.43170114689;6344.55588108832;6084.72618732157;6111.297200821907;6233.594816336935;6246.969250073744;6276.435120839124;5043.546080852722;5045.949540504603;5048.848534543969;5067.467915868836;5072.492750724917;4888.73111978841;4932.654714170009;4946.230111137775;4997.975010124945;5014.674046187004;4915.410150781893;4929.728864912428;4957.801687932479;4979.153543897528;5014.774335154909;4907.92638110425;4908.803647854082;4959.305697202394;4970.801167953277;4976.278439626234;4466.173757854807;4504.572065653758;4552.68131230814;4565.863024109282;4579.129965306614;6191.566590338678;6217.378262173792;6278.937210627881;6296.87406251877;6306.747730090791;5819.738111784937;5837.6497410155525;5881.529477641821;5882.764689412461;5888.499477544414;6588.209414870246;6593.307702691244;6595.769148079842;6667;6678.632675202862;4866.31871537985;5043.344365232533;5055.165897626887;5086.593072554224;5088.313077734496;6632.801015969529;6785.389314961628;6797.728090876359;6882.283566873932;6920.30796920309;5123.513266239701;5134.409542902614;5180.533751962266;5198.16829307309;5208.322918020709;5282.788688452496;5302.09864323066;5317.468253174651;5331.573474122061;5332.360116785933;5846.327672317653;5848.649081055065;5858.619189752652;5869.677167755729;5891.558133140032;6630.138082049302;6654.802135615636;6696.59820410777;6722.495812814059;6758.83102922421;1827.872048956587;1831.6611426885802;1832.1480511562188;1832.193834712722;1857.2570971611462;1238.182799352423;1287.137617796079;1300.7723648361498;1303.3157592264138;1327.595083499542;5967.587615036362;6078.328459673625;6151.692415379213;6172.5679202456295;6187.288461826947;6534.607923524603;6572.408483236436;6587.308332625005;6667.19993600771;6763.830904227335;5999.310079340845;6080.331163572092;6178.042403427476;6233.407826256498;6272.6236425814595;3569.5538057742783;3596.3166998270244;3604.873829415958;3619.529461170084;3626.476879710528;6756.290589488131;6789.558678685869;6824.965875170592;6844.555103918329;6902.827429314207;6975.267596902252;7029.472789540702;7066.964665176744;7095.3968912643;7111.679974401164;7009.1589009319205;7027.472939529555;7041.225465198926;7044.577325360495;7057.7176912922905;6641.236257830218;6749.730010799513;6771.695273712597;6812.96593517049;6818.284080171709;6563.540552161303;6626.403623673892;6626.56927299724;6762.357576030269;6763;6779.220389655253;6797.320267973361;6816.807058764795;6829.74109935337;6833.965830170818;5171.120909445479;5212.0878846201;5214.217867319932;5214.374275087014;5251.133562962068;6600.966995164993;6604.768833090819;6626.337366263335;6770.322967703387;6799.898001529882;6414.390632889868;6493.577917435352;6571.145751052332;6594.406503414716;6692.799216023527;6424.93575064262;6505.544611877123;6518.511111666549;6608.306127856506;6644.069830223869;6543.312952139957;6557.655680585373;6580.736770529125;6580.967095164494;6610.933890661224;6671.232808226922;6685.799426017227;6715.764948226789;6716.1604799400075;6775.830604234933;6457.354264573505;6461.61230326182;6461.741530338733;6491.188601424822;6552.8361790955605 12:03:48 INFO - PID 15742 | |5;yui.html;976.2287792643812;990.8563258327542;1010.171659239424;1011.448760425568;1020.6835880876929;18459;18812.34156804512;18822.153003114858;18889.811101888976;20458.283960061402;19567.412977610693;19684;19730.605387892232;19753.901230493862;19756.30852920148;1019.5208252121491;1044.937303761773;1049.0715716590835;1050.396022287184;1050.837120246363;1049.3441599000626;1064.978700425991;1067.386252904583;1068.647346375694;1069.3049517813406;1064.7710742190427;1115.871674757401;1117.972050698731;1118.546988469671;1130.7229728716477;1098.0940723902772;1104.1829046505609;1106.4854842498278;1106.7675788084512;1109.3343993603814;795.6499140378215;810.8783682447621;815.0667485728867;817.4237162800212;819.0949001353479;21066;21393.25123620666;21398.679019814714;21398.679019814714;21458.892705536528;22525;23005.76994230053;23184.65223021656;23551.29346119619;23557.29328120159;17146.57133571658;17358.82641173585;17470.126493675394;17768.822311776847;17787.19957601911;3947.0921688011917;3978.6021397860272;3979;3981.7610943343493;3983.8406463741417;130642;157195;157885;158632.20683896623;161308.99999999884;18793.15430805617;18880.24479020824;18930.148143333583;18972.241110355706;18979.90510047441;34486.965391038306;34700.82649586786;35276.47085293723;35404;35635;9781.119699227103;9794.412335259907;9837.901620983841;9878.160356369644;9899.752506187402;4389.429374181336;4407.052483715952;4490.685652004328;4491.214037543416;4507.774611269423;5798.478136967693;5912.3496415394275;5916.1421593868645;5929.258842644669;5947.04847224442;1217.1297522271618;1239.3431481314917;1241.1684171604866;1243.3339325304137;1263.9873601263869;726.4551586310267;744.7244519527809;746.145663215626;763.3969164360093;763.8395936853212;13403.396847141901;13798.17210967345;13810.37853296584;14127.505537306144;14187.290635468185;697.7836870570038;708.9896896921865;714.9177844547944;722.4978639845257;723.1286300008477;5779.133130030445;5815.709214539256;5847.26909136358;5852.297724273115;5945.078512830518;140657;142188;147392;147765;147781;104072;126701.36649316695;130063;130744;134547;112261.43869280601;112585;112889.43555282171;114487;121734.8270121928;13875.375608097458;14539.41842326295;14600.926995364955;14606.26968651542;14681.41274349014;55226;55390.44609553853;55485;55673.44326556844;55813.441865580826;71672;73567;73787;73929.6303518479;74445.62777186296;20466.795332046488;21003.73977561351;21096.683549747075;21197.7880221202;21277.148914043264;21852.78147218571;22389.104435822384;22422.887885561122;22446;22642.886785565966;20627.278045268344;20628.381148565568;20710.896445517676;20760.273390431263;20845.895770521656;16955.576110597332;17028.659426811642;17102;17218.483445496655;17300.394486192923;20763;20830.687539686613;20947.8952605236;21114.944252787605;21278.680819788024;13360.799588005993;13553.186808791505;13605.86394136046;13668.52160174389;13905.721885562434;15574.299156538209;15700.92149539245;15830.050196987757;16051.839481605502;16117 12:03:48 INFO - PID 15742 | __end_tp_report 12:03:48 INFO - PID 15742 | __start_cc_report 12:03:48 INFO - PID 15742 | _x_x_mozilla_cycle_collect,256 12:03:48 INFO - PID 15742 | __end_cc_report 12:03:48 INFO - PID 15742 | __startTimestamp1505934228394__endTimestamp 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | ------- Summary: start ------- 12:03:48 INFO - PID 15742 | Number of tests: 6 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#0] dojo.html Cycles:165 Average:6238.56 Median:6502.02 stddev:744.00 (11.4%) stddev-sans-first:720.76 12:03:48 INFO - PID 15742 | Values: 3775.5 3782.5 3826.3 3828.6 3849.1 6073.2 6185.1 6232.7 6257.1 6309.7 6202.4 6204.8 6266.1 6292.4 6313.5 5572.6 5598.0 5617.9 5633.0 5673.8 5717.6 5718.2 5728.3 5728.7 5778.8 5663.9 5672.4 5697.4 5780.7 5781.7 5469.5 5564.4 5581.7 5669.4 5695.6 5602.2 5605.4 5691.5 5692.1 5696.7 6126.5 6153.7 6206.7 6259.4 6353.0 6709.9 6721.4 6747.0 6765.1 6795.1 6872.5 6915.9 6916.8 6925.9 6936.3 6324.3 6337.5 6406.3 6409.7 6434.2 6955.5 6960.9 6967.5 6980.1 7065.1 6577.7 6596.7 6603.9 6652.5 6807.0 6747.2 6760.4 6794.8 6805.1 6817.3 6802.3 6811.3 6822.8 6823.1 6859.7 6738.0 6739.2 6740.8 6830.8 6847.3 4827.6 4895.1 4898.7 4927.9 4929.9 4448.7 4483.6 4493.5 4511.0 4513.9 6107.3 6176.7 6216.1 6237.0 6266.8 6739.9 6766.5 6832.5 6836.7 6844.9 6023.3 6120.1 6132.4 6195.8 6230.5 5457.7 5484.8 5522.9 5524.9 5532.9 6837.3 6989.1 6995.4 7011.9 7025.0 6771.4 6779.4 6876.6 6885.2 6887.0 6786.9 6889.4 6898.7 6924.9 6979.2 6753.3 6754.1 6758.7 6761.3 6774.2 6772.8 6779.6 6787.6 6871.9 6884.3 6528.3 6548.9 6623.4 6649.9 6654.2 6438.0 6502.0 6512.8 6526.7 6626.2 6469.5 6496.7 6523.8 6524.7 6527.5 6545.2 6618.6 6633.8 6663.6 6683.0 6303.3 6373.2 6405.7 6409.0 6504.7 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#1] ext.html Cycles:180 Average:42125.37 Median:36361.64 stddev:63913.74 (175.8%) stddev-sans-first:64018.12 12:03:48 INFO - PID 15742 | Values: 909.7 952.2 953.4 1001.2 1005.8 42855.6 44183.6 44255.1 44324.0 44332.6 41603.0 41634.0 41805.6 41872.2 41909.6 7686.9 7758.7 7786.3 7811.1 7832.5 7641.7 7727.0 7752.7 7754.2 7773.6 8250.3 8442.6 8504.6 8520.0 8523.3 8409.4 8411.5 8444.2 8457.5 8481.1 8021.2 8148.6 8293.9 8300.0 8309.8 40452.8 40813.6 40818.0 40872.4 40955.0 3775.7 3795.2 3811.0 3835.4 3835.5 33316.5 33362.0 33383.0 33487.0 33565.7 5442.9 5499.8 5511.5 5527.4 5545.9 205517.0 209191.0 210601.0 211010.0 231422.0 53297.5 54126.7 54160.5 54166.7 54194.7 57013.7 57032.7 57064.7 57188.7 57241.1 14259.7 14307.1 14484.7 14517.9 14537.9 10744.2 10762.9 10763.8 10766.8 10768.5 15343.6 15554.4 15569.0 15574.8 15627.5 5855.4 6116.8 6124.1 6154.4 6166.4 1100.0 1106.3 1106.3 1109.3 1123.0 25159.6 25243.7 25308.4 25353.0 25423.9 1155.9 1184.7 1195.4 1196.2 1200.1 13452.3 13511.4 13529.0 13568.5 13603.9 279692.0 280961.0 281156.0 281179.0 281438.0 57932.7 58179.7 58219.7 58315.4 58332.7 1496.0 1518.4 1531.8 1545.5 1552.2 24992.0 25109.5 25133.0 25239.1 25369.7 41294.6 41333.0 41363.2 41366.2 41448.2 236209.0 236785.0 237350.0 237730.0 238006.0 33435.0 33622.7 34335.1 36183.6 36539.6 44855.3 46730.0 46914.5 47028.0 47357.3 33943.0 34121.8 34407.5 34931.3 34952.3 34007.8 34354.7 34523.5 34592.0 35140.0 39308.8 39998.8 40386.8 40482.6 40547.4 31992.5 32642.3 32855.5 32885.7 33147.8 25073.7 25147.0 25271.9 25942.1 26025.2 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#2] jquery.html Cycles:180 Average:39641.96 Median:13177.09 stddev:99579.12 (755.7%) stddev-sans-first:99815.28 12:03:48 INFO - PID 15742 | Values: 579.9 598.3 598.6 613.1 638.3 23244.3 24009.6 24042.8 24051.2 24056.2 23096.9 24861.8 25030.1 25053.9 25108.4 6627.4 6820.2 6822.5 6831.9 6838.5 6375.9 6693.2 6695.3 6861.5 6876.6 6642.1 6656.5 6668.7 6670.3 6672.2 6495.2 6600.5 6642.3 6643.4 6644.4 6271.7 6321.3 6327.8 6327.9 6328.6 30429.8 30937.7 30941.4 30957.5 31006.7 2299.7 2330.4 2337.6 2341.6 2344.5 20757.6 21338.8 21707.1 21805.2 21944.5 2546.6 2560.2 2591.2 2637.3 2638.2 138221.0 142745.3 145472.0 156318.2 158539.0 16068.3 16459.3 16641.3 16803.3 16925.6 26255.3 26438.7 26485.2 26501.5 26545.9 9120.5 9152.9 9268.8 9348.7 9360.3 7911.4 7922.0 7985.4 7985.4 8022.4 9989.0 10115.2 10121.7 10161.4 10221.7 2956.8 2959.6 2975.4 3011.1 3041.3 1040.5 1061.9 1062.1 1064.0 1066.2 21727.7 21886.7 21901.9 21998.7 22047.9 1083.3 1092.5 1097.4 1111.7 1116.9 11904.2 12141.9 12154.4 12256.0 12419.3 582261.0 590532.0 594383.0 599724.0 608862.0 128565.4 129540.0 130482.0 131262.0 135236.0 1105.8 1157.2 1183.4 1199.4 1239.7 22665.2 23040.0 23152.3 23174.7 23352.9 60483.7 60962.7 62091.7 63961.0 65568.0 77256.6 77645.6 78315.0 78552.0 79379.6 16066.0 16245.7 16354.8 16441.7 16462.0 24967.3 25220.7 25388.9 25395.7 25452.2 20163.0 20310.5 20788.8 20847.8 21020.4 18282.3 18283.0 18476.5 18484.1 18936.4 20432.0 21093.6 21101.5 21136.5 21405.3 16334.6 16337.2 16434.8 16437.1 16482.6 19592.6 20223.3 20628.0 20646.7 20667.0 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#3] mootools.html Cycles:180 Average:10363.45 Median:2594.83 stddev:7733.14 (298.0%) stddev-sans-first:7725.17 12:03:48 INFO - PID 15742 | Values: 1348.6 1417.5 1433.0 1437.3 1441.4 16786.7 17459.2 17489.5 17497.7 17498.0 17080.5 17109.7 17248.3 17261.7 17263.3 2729.1 2783.3 2834.8 2839.4 2839.5 2732.5 2779.7 2791.5 2792.1 2794.9 2724.3 2737.1 2737.5 2831.3 2831.6 2767.7 2785.6 2789.7 2799.7 2801.5 2590.8 2598.8 2608.8 2629.6 2630.3 16331.6 16724.0 16740.7 16755.2 16762.5 8164.1 8483.2 8487.7 8488.4 8494.0 5070.6 5299.3 5382.8 5426.4 5426.7 1977.7 2051.9 2067.3 2068.4 2128.8 30113.4 30419.8 30451.8 30482.7 30521.2 7051.5 7318.2 7350.1 7399.6 7460.3 19575.3 19577.9 19598.7 19604.9 19639.9 8287.5 8424.8 8446.3 8451.6 8458.8 7443.3 7447.9 7628.1 7651.7 7733.4 5390.7 5533.7 5555.2 5596.4 5643.7 1592.3 1598.3 1614.7 1617.5 1642.5 801.2 914.8 928.3 935.6 956.2 9042.2 9314.0 9381.9 9394.4 9445.4 1042.9 1061.4 1071.1 1079.2 1079.7 5599.3 5605.0 5692.9 5815.9 5914.8 23590.4 23974.0 25146.7 25711.7 25730.6 23652.9 25205.1 25235.0 25260.2 25273.6 11688.2 11888.2 11938.5 11974.5 12033.3 8667.6 8742.2 8823.2 8825.7 8869.2 20593.7 20810.6 21655.6 21767.8 22079.2 21543.6 21607.5 21736.8 21942.8 21957.7 12315.9 12354.9 12429.9 12430.2 12435.3 15787.4 15789.0 15918.9 16000.0 16037.5 12083.2 12285.1 12492.9 12520.4 12745.2 11640.3 11963.9 12013.5 12046.2 12364.3 10727.4 11015.8 11025.3 11030.6 11032.9 7988.3 8001.4 8016.8 8021.8 8034.6 7980.8 8064.6 8163.0 8216.6 8236.2 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#4] prototype.html Cycles:180 Average:5626.51 Median:6259.80 stddev:1565.31 (25.0%) stddev-sans-first:1522.64 12:03:48 INFO - PID 15742 | Values: 550.9 557.9 576.4 585.7 586.9 5724.1 6288.4 6303.7 6314.4 6344.6 6084.7 6111.3 6233.6 6247.0 6276.4 5043.5 5045.9 5048.8 5067.5 5072.5 4888.7 4932.7 4946.2 4998.0 5014.7 4915.4 4929.7 4957.8 4979.2 5014.8 4907.9 4908.8 4959.3 4970.8 4976.3 4466.2 4504.6 4552.7 4565.9 4579.1 6191.6 6217.4 6278.9 6296.9 6306.7 5819.7 5837.6 5881.5 5882.8 5888.5 6588.2 6593.3 6595.8 6667.0 6678.6 4866.3 5043.3 5055.2 5086.6 5088.3 6632.8 6785.4 6797.7 6882.3 6920.3 5123.5 5134.4 5180.5 5198.2 5208.3 5282.8 5302.1 5317.5 5331.6 5332.4 5846.3 5848.6 5858.6 5869.7 5891.6 6630.1 6654.8 6696.6 6722.5 6758.8 1827.9 1831.7 1832.1 1832.2 1857.3 1238.2 1287.1 1300.8 1303.3 1327.6 5967.6 6078.3 6151.7 6172.6 6187.3 6534.6 6572.4 6587.3 6667.2 6763.8 5999.3 6080.3 6178.0 6233.4 6272.6 3569.6 3596.3 3604.9 3619.5 3626.5 6756.3 6789.6 6825.0 6844.6 6902.8 6975.3 7029.5 7067.0 7095.4 7111.7 7009.2 7027.5 7041.2 7044.6 7057.7 6641.2 6749.7 6771.7 6813.0 6818.3 6563.5 6626.4 6626.6 6762.4 6763.0 6779.2 6797.3 6816.8 6829.7 6834.0 5171.1 5212.1 5214.2 5214.4 5251.1 6601.0 6604.8 6626.3 6770.3 6799.9 6414.4 6493.6 6571.1 6594.4 6692.8 6424.9 6505.5 6518.5 6608.3 6644.1 6543.3 6557.7 6580.7 6581.0 6610.9 6671.2 6685.8 6715.8 6716.2 6775.8 6457.4 6461.6 6461.7 6491.2 6552.8 12:03:48 INFO - PID 15742 | 12:03:48 INFO - PID 15742 | [#5] yui.html Cycles:180 Average:28359.86 Median:19755.10 stddev:40928.43 (207.2%) stddev-sans-first:40991.59 12:03:48 INFO - PID 15742 | Values: 976.2 990.9 1010.2 1011.4 1020.7 18459.0 18812.3 18822.2 18889.8 20458.3 19567.4 19684.0 19730.6 19753.9 19756.3 1019.5 1044.9 1049.1 1050.4 1050.8 1049.3 1065.0 1067.4 1068.6 1069.3 1064.8 1115.9 1118.0 1118.5 1130.7 1098.1 1104.2 1106.5 1106.8 1109.3 795.6 810.9 815.1 817.4 819.1 21066.0 21393.3 21398.7 21398.7 21458.9 22525.0 23005.8 23184.7 23551.3 23557.3 17146.6 17358.8 17470.1 17768.8 17787.2 3947.1 3978.6 3979.0 3981.8 3983.8 130642.0 157195.0 157885.0 158632.2 161309.0 18793.2 18880.2 18930.1 18972.2 18979.9 34487.0 34700.8 35276.5 35404.0 35635.0 9781.1 9794.4 9837.9 9878.2 9899.8 4389.4 4407.1 4490.7 4491.2 4507.8 5798.5 5912.3 5916.1 5929.3 5947.0 1217.1 1239.3 1241.2 1243.3 1264.0 726.5 744.7 746.1 763.4 763.8 13403.4 13798.2 13810.4 14127.5 14187.3 697.8 709.0 714.9 722.5 723.1 5779.1 5815.7 5847.3 5852.3 5945.1 140657.0 142188.0 147392.0 147765.0 147781.0 104072.0 126701.4 130063.0 130744.0 134547.0 112261.4 112585.0 112889.4 114487.0 121734.8 13875.4 14539.4 14600.9 14606.3 14681.4 55226.0 55390.4 55485.0 55673.4 55813.4 71672.0 73567.0 73787.0 73929.6 74445.6 20466.8 21003.7 21096.7 21197.8 21277.1 21852.8 22389.1 22422.9 22446.0 22642.9 20627.3 20628.4 20710.9 20760.3 20845.9 16955.6 17028.7 17102.0 17218.5 17300.4 20763.0 20830.7 20947.9 21114.9 21278.7 13360.8 13553.2 13605.9 13668.5 13905.7 15574.3 15700.9 15830.1 16051.8 16117.0 12:03:48 INFO - PID 15742 | -------- Summary: end -------- 12:03:48 INFO - PID 15742 | 12:03:49 INFO - TEST-INFO | 15742: exit 0 12:03:49 INFO - TEST-OK | dromaeo_css | took 1108195ms 12:03:49 INFO - TEST-START | kraken 12:03:49 INFO - Initialising browser for kraken test... 12:03:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38127/getInfo.html -profile /tmp/tmp9iIIT6/profile 12:03:49 INFO - TEST-INFO | started process 16114 (/builds/slave/test/build/application/firefox/firefox http://localhost:38127/getInfo.html) 12:03:54 INFO - TEST-INFO | 16114: exit 0 12:03:54 INFO - Browser initialized. 12:03:54 INFO - Running cycle 1/1 for kraken test... 12:03:54 INFO - Using env: {'DISPLAY': ':0', 12:03:54 INFO - 'HOME': '/home/cltbld', 12:03:54 INFO - 'JSGC_DISABLE_POISONING': '1', 12:03:54 INFO - 'LANG': 'en_US.UTF-8', 12:03:54 INFO - 'LANGUAGE': 'en_US:en', 12:03:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:03:54 INFO - 'LOGNAME': 'cltbld', 12:03:54 INFO - 'MAIL': '/var/mail/cltbld', 12:03:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:03:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:03:54 INFO - 'MOZ_CRASHREPORTER': '1', 12:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:03:54 INFO - 'MOZ_NO_REMOTE': '1', 12:03:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:54 INFO - 'NO_EM_RESTART': '1', 12:03:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:54 INFO - 'PWD': '/builds/slave/test', 12:03:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:03:54 INFO - 'RUST_BACKTRACE': 'full', 12:03:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:03:54 INFO - 'SHELL': '/bin/bash', 12:03:54 INFO - 'SHLVL': '1', 12:03:54 INFO - 'TERM': 'linux', 12:03:54 INFO - 'TMOUT': '86400', 12:03:54 INFO - 'USER': 'cltbld', 12:03:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536', 12:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:54 INFO - '_': '/tools/buildbot/bin/python'} 12:03:54 INFO - TEST-INFO | started process 16352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9iIIT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:55 INFO - PID 16352 | 12:03:55 INFO - PID 16352 | (/builds/slave/test/build/application/firefox/firefox:16401): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:03:55 INFO - PID 16352 | 12:04:05 INFO - PID 16352 | RSS: Main: 147283968 12:04:05 INFO - PID 16352 | 12:04:08 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38127/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:08 INFO - PID 16352 | RSS: Main: 152961024 12:04:08 INFO - PID 16352 | 12:04:11 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38127/tests/kraken/driver.html?testName=audio-dft) 12:04:12 INFO - PID 16352 | RSS: Main: 152903680 12:04:12 INFO - PID 16352 | 12:04:14 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38127/tests/kraken/driver.html?testName=audio-fft) 12:04:15 INFO - PID 16352 | RSS: Main: 149852160 12:04:15 INFO - PID 16352 | 12:04:17 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38127/tests/kraken/driver.html?testName=audio-oscillator) 12:04:18 INFO - PID 16352 | RSS: Main: 151175168 12:04:18 INFO - PID 16352 | 12:04:20 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:04:20 INFO - PID 16352 | RSS: Main: 150794240 12:04:20 INFO - PID 16352 | 12:04:24 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38127/tests/kraken/driver.html?testName=imaging-darkroom) 12:04:24 INFO - PID 16352 | RSS: Main: 150839296 12:04:24 INFO - PID 16352 | 12:04:28 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38127/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:28 INFO - PID 16352 | RSS: Main: 151969792 12:04:28 INFO - PID 16352 | 12:04:31 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38127/tests/kraken/driver.html?testName=json-parse-financial) 12:04:32 INFO - PID 16352 | RSS: Main: 153321472 12:04:32 INFO - PID 16352 | 12:04:33 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:34 INFO - PID 16352 | RSS: Main: 153243648 12:04:34 INFO - PID 16352 | 12:04:35 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:36 INFO - PID 16352 | RSS: Main: 153047040 12:04:36 INFO - PID 16352 | 12:04:38 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:39 INFO - PID 16352 | RSS: Main: 150679552 12:04:39 INFO - PID 16352 | 12:04:41 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:04:42 INFO - PID 16352 | RSS: Main: 150663168 12:04:42 INFO - PID 16352 | 12:04:45 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:04:45 INFO - PID 16352 | RSS: Main: 151154688 12:04:45 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | Cycle 1(1): loaded http://localhost:38127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38127/tests/kraken/driver.html?testName=ai-astar) 12:04:47 INFO - PID 16352 | RSS: Main: 152809472 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | __start_tp_report 12:04:47 INFO - PID 16352 | _x_x_mozilla_page_load 12:04:47 INFO - PID 16352 | _x_x_mozilla_page_load_details 12:04:47 INFO - PID 16352 | |i|pagename|runs| 12:04:47 INFO - PID 16352 | |0;ai-astar;105;106;105;107;106;106;117;107;104;105 12:04:47 INFO - PID 16352 | |1;audio-beat-detection;113;113;113;113;111;143;115;115;123;113 12:04:47 INFO - PID 16352 | |2;audio-dft;163;166;165;161;161;160;163;161;167;166 12:04:47 INFO - PID 16352 | |3;audio-fft;73;73;73;71;72;74;74;74;74;75 12:04:47 INFO - PID 16352 | |4;audio-oscillator;78;79;78;80;77;78;77;78;78;78 12:04:47 INFO - PID 16352 | |5;imaging-gaussian-blur;110;113;109;114;114;111;116;115;115;114 12:04:47 INFO - PID 16352 | |6;imaging-darkroom;150;151;149;150;149;149;150;150;152;150 12:04:47 INFO - PID 16352 | |7;imaging-desaturate;95;94;93;93;95;93;95;94;95;93 12:04:47 INFO - PID 16352 | |8;json-parse-financial;44;44;46;44;45;45;45;44;44;43 12:04:47 INFO - PID 16352 | |9;json-stringify-tinderbox;37;37;37;38;37;38;41;37;37;37 12:04:47 INFO - PID 16352 | |10;stanford-crypto-aes;70;73;72;73;74;70;72;75;73;71 12:04:47 INFO - PID 16352 | |11;stanford-crypto-ccm;107;105;102;110;107;111;106;106;109;102 12:04:47 INFO - PID 16352 | |12;stanford-crypto-pbkdf2;156;155;149;150;151;153;150;160;153;152 12:04:47 INFO - PID 16352 | |13;stanford-crypto-sha256-iterative;67;62;58;59;64;62;61;70;63;62 12:04:47 INFO - PID 16352 | __end_tp_report 12:04:47 INFO - PID 16352 | __start_cc_report 12:04:47 INFO - PID 16352 | _x_x_mozilla_cycle_collect,717 12:04:47 INFO - PID 16352 | __end_cc_report 12:04:47 INFO - PID 16352 | __startTimestamp1505934287606__endTimestamp 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | ------- Summary: start ------- 12:04:47 INFO - PID 16352 | Number of tests: 14 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#0] ai-astar Cycles:10 Average:106.80 Median:106.00 stddev:3.71 (3.5%) stddev-sans-first:3.87 12:04:47 INFO - PID 16352 | Values: 105.0 106.0 105.0 107.0 106.0 106.0 117.0 107.0 104.0 105.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:114.00 stddev:9.64 (8.5%) stddev-sans-first:10.10 12:04:47 INFO - PID 16352 | Values: 113.0 113.0 113.0 113.0 111.0 143.0 115.0 115.0 123.0 113.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:2.54 (1.5%) stddev-sans-first:2.69 12:04:47 INFO - PID 16352 | Values: 163.0 166.0 165.0 161.0 161.0 160.0 163.0 161.0 167.0 166.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#3] audio-fft Cycles:10 Average:73.30 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 12:04:47 INFO - PID 16352 | Values: 73.0 73.0 73.0 71.0 72.0 74.0 74.0 74.0 74.0 75.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 12:04:47 INFO - PID 16352 | Values: 78.0 79.0 78.0 80.0 77.0 78.0 77.0 78.0 78.0 78.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:2.33 (2.0%) stddev-sans-first:2.19 12:04:47 INFO - PID 16352 | Values: 110.0 113.0 109.0 114.0 114.0 111.0 116.0 115.0 115.0 114.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 12:04:47 INFO - PID 16352 | Values: 150.0 151.0 149.0 150.0 149.0 149.0 150.0 150.0 152.0 150.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.50 stddev:0.94 (1.0%) stddev-sans-first:0.93 12:04:47 INFO - PID 16352 | Values: 95.0 94.0 93.0 93.0 95.0 93.0 95.0 94.0 95.0 93.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:44.50 stddev:0.84 (1.9%) stddev-sans-first:0.88 12:04:47 INFO - PID 16352 | Values: 44.0 44.0 46.0 44.0 45.0 45.0 45.0 44.0 44.0 43.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:37.00 stddev:1.26 (3.4%) stddev-sans-first:1.32 12:04:47 INFO - PID 16352 | Values: 37.0 37.0 37.0 38.0 37.0 38.0 41.0 37.0 37.0 37.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:73.00 stddev:1.64 (2.2%) stddev-sans-first:1.51 12:04:47 INFO - PID 16352 | Values: 70.0 73.0 72.0 73.0 74.0 70.0 72.0 75.0 73.0 71.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.00 stddev:3.03 (2.8%) stddev-sans-first:3.21 12:04:47 INFO - PID 16352 | Values: 107.0 105.0 102.0 110.0 107.0 111.0 106.0 106.0 109.0 102.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:153.00 stddev:3.35 (2.2%) stddev-sans-first:3.36 12:04:47 INFO - PID 16352 | Values: 156.0 155.0 149.0 150.0 151.0 153.0 150.0 160.0 153.0 152.0 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:3.55 (5.7%) stddev-sans-first:3.43 12:04:47 INFO - PID 16352 | Values: 67.0 62.0 58.0 59.0 64.0 62.0 61.0 70.0 63.0 62.0 12:04:47 INFO - PID 16352 | -------- Summary: end -------- 12:04:47 INFO - PID 16352 | 12:04:47 INFO - PID 16352 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:04:48 INFO - TEST-INFO | 16352: exit 0 12:04:48 INFO - TEST-OK | kraken | took 59290ms 12:04:48 INFO - SUITE-END | took 1167s 12:04:48 INFO - Completed test suite (00:19:27) 12:04:48 INFO - javascript benchmark 12:04:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9072.738071047426, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3775.509183806105, 3782.5082739243903, 3826.3112639724854, 3828.6171382861735, 3849.095462566297, 6073.240844894388, 6185.134081228632, 6232.719527621257, 6257.061440783879, 6309.747610095596, 6202.4417802397775, 6204.78283260086, 6266.060090986354, 6292.402221788934, 6313.526485513594, 5572.637778544382, 5598.0, 5617.9438205617935, 5633.0, 5673.773049078032, 5717.628354156987, 5718.228039214715, 5728.283964504437, 5728.742206600713, 5778.7977420790285, 5663.8584035399235, 5672.376038635747, 5697.401772813857, 5780.710964451781, 5781.739821708034, 5469.480399362054, 5564.443555644443, 5581.6930068846195, 5669.433056694339, 5695.629784064023, 5602.187682786014, 5605.439456054402, 5691.4877661010705, 5692.0608099663505, 5696.6866822324755, 6126.540509461808, 6153.692315384257, 6206.689665516751, 6259.405356491126, 6353.0, 6709.899351509731, 6721.395074443323, 6747.021681856152, 6765.052892594991, 6795.082663840368, 6872.518923675345, 6915.89626155608, 6916.827079323007, 6925.930740692579, 6936.306369363074, 6324.33594472583, 6337.524685648595, 6406.327335629739, 6409.7436102555375, 6434.163558737381, 6955.513114081966, 6960.895586566206, 6967.54710943787, 6980.127484064492, 7065.116860392451, 6577.736890524421, 6596.703148358335, 6603.933960660428, 6652.467802575782, 6807.047013418125, 6747.190337159573, 6760.357766012221, 6794.76218332356, 6805.081314022544, 6817.318268173143, 6802.319768023158, 6811.318868113248, 6822.761203357859, 6823.147106611674, 6859.691313890887, 6737.9663101685155, 6739.191297044386, 6740.83147921296, 6830.829229269209, 6847.349501797321, 4827.565519103227, 4895.069936712013, 4898.657094003385, 4927.901441971212, 4929.926051109236, 4448.688591798543, 4483.641308695296, 4493.505714371417, 4511.0, 4513.932291015637, 6107.328193898667, 6176.66028368444, 6216.098665693449, 6237.033259844731, 6266.843328916813, 6739.898901516482, 6766.49251306154, 6832.521723479408, 6836.726530938806, 6844.931550684529, 6023.27720673522, 6120.112583675431, 6132.356102609162, 6195.783147589813, 6230.501559875199, 5457.727113644302, 5484.7531861066345, 5522.889542209134, 5524.917126243109, 5532.917006244909, 6837.3162683731225, 6989.126359205099, 6995.4053905417595, 7011.859762804817, 7025.0, 6771.3905748482875, 6779.389854912983, 6876.553024053421, 6885.242623311332, 6887.035814985906, 6786.93213067863, 6889.448844092561, 6898.724051038103, 6924.896126558005, 6979.162500499972, 6753.257141714505, 6754.12196414463, 6758.662066896733, 6761.3238676132, 6774.220964588938, 6772.830679233059, 6779.6271205084195, 6787.626680532618, 6871.896921546281, 6884.345987131214, 6528.314526974599, 6548.934510655023, 6623.437007854193, 6649.867002660017, 6654.168228971379, 6438.0, 6502.0246962955935, 6512.804615861532, 6526.653322578381, 6626.237982632059, 6469.45009674183, 6496.70764815575, 6523.836904077436, 6524.706388212447, 6527.477801775942, 6545.181852268466, 6618.63597502142, 6633.767818126343, 6663.566868153748, 6683.0, 6303.306636269915, 6373.171487706569, 6405.679716014274, 6409.0, 6504.707288171949], "value": 6187.435657458332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.6997990663082, 952.2096659772394, 953.4279432340594, 1001.2240513601957, 1005.7686732051633, 42855.571444285546, 44183.55816441835, 44255.11489770203, 44324.0, 44332.55667443325, 41603.0, 41634.0, 41805.58194418055, 41872.162556748845, 41909.58090419095, 7686.9231307686905, 7758.6896524138965, 7786.260305271018, 7811.140774514799, 7832.530048197098, 7641.656125474339, 7726.961365193166, 7752.689892404325, 7754.224577542257, 7773.611319434006, 8250.257476827084, 8442.57787110645, 8504.617292221865, 8519.977602687655, 8523.318134549252, 8409.411341206118, 8411.495310281372, 8444.155584441538, 8457.450265732768, 8481.109483504235, 8021.157778433298, 8148.633311500997, 8293.875591866126, 8300.0, 8309.750707478785, 40452.79773601113, 40813.591864081274, 40818.0, 40872.38691419631, 40955.0, 3775.6979441644603, 3795.1650636859845, 3811.00913762421, 3835.4246862970776, 3835.53973523179, 33316.50025249623, 33362.0, 33383.0, 33487.0, 33565.6643433565, 5442.91835622466, 5499.807506737245, 5511.53151982082, 5527.419620939824, 5545.889082218373, 205517.0, 209191.0, 210601.0, 211010.0, 231422.0, 53297.46702533003, 54126.72936635291, 54160.45839541554, 54166.729166353914, 54194.72902635462, 57013.71493142591, 57032.714836425555, 57064.71467642718, 57188.71405642945, 57241.14138287929, 14259.714805703828, 14307.141571505743, 14484.710305793826, 14517.85482145165, 14537.85462145365, 10744.247902646739, 10762.892371076188, 10763.83854242187, 10766.838497422545, 10768.515416806262, 15343.61640958985, 15554.377824886878, 15569.0, 15574.844251557566, 15627.531174064796, 5855.3851845556455, 6116.847078823065, 6124.11200375943, 6154.3845615438095, 6166.445019948226, 1099.9560017599206, 1106.269861891148, 1106.330669944688, 1109.3177695717238, 1123.0229700160912, 25159.62260566093, 25243.74756252414, 25308.39832722947, 25353.0, 25423.87288063585, 1155.936423496699, 1184.6979020349756, 1195.354508565365, 1196.1746394987604, 1200.0759415250209, 13452.260125692985, 13511.391987360592, 13529.0, 13568.457261709618, 13603.863961360457, 279692.0, 280961.0, 281156.0, 281179.0, 281438.0, 57932.710336448894, 58179.709101454224, 58219.70890145607, 58315.416845831, 58332.70833645805, 1495.9850401496064, 1518.3698765012616, 1531.7549192129206, 1545.51316335354, 1552.2161308539116, 24992.0, 25109.548863539665, 25133.0, 25239.11663091783, 25369.74630253748, 41294.55469058568, 41333.0, 41363.1727365445, 41366.1726765469, 41448.171036579704, 236209.0, 236785.0, 237350.0, 237730.0, 238006.0, 33435.0, 33622.66377336195, 34335.08151807024, 36183.63816361908, 36539.63460365362, 44855.32717009182, 46730.0, 46914.53085469102, 47028.0, 47357.289640656105, 33943.0, 34121.82939085289, 34407.483887741204, 34931.301373972885, 34952.300953980266, 34007.82996085004, 34354.65645343515, 34523.48214776831, 34592.0, 35140.0, 39308.80345598254, 39998.80000599979, 40386.798066010655, 40482.595174049064, 40547.391789122594, 31992.520112198803, 32642.347153057282, 32855.50716739203, 32885.67114328922, 33147.834260829506, 25073.749262507143, 25147.0, 25271.87364063168, 25942.092026778973, 26025.21924342273], "value": 18351.22230314783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9217105690733, 598.2880372356892, 598.6228675934161, 613.1109890658545, 638.3393188050368, 23244.302670919857, 24009.63985540216, 24042.75957240427, 24051.15820946265, 24056.158034468797, 23096.8845155774, 24861.75138248617, 25030.123945661904, 25053.87473062637, 25108.372290692743, 6627.37039981201, 6820.181578210597, 6822.522423430361, 6831.897521537181, 6838.521303508756, 6375.936240637604, 6693.23027851796, 6695.3304669533145, 6861.48538859585, 6876.587404755731, 6642.136522252101, 6656.534042617019, 6668.699908504129, 6670.299618540056, 6672.232693240267, 6495.188101487314, 6600.504962127836, 6642.335766423367, 6643.435307998801, 6644.402003819631, 6271.655058971754, 6321.304656487782, 6327.778527751507, 6327.873442531123, 6328.6202827830475, 30429.847850760827, 30937.690623093706, 30941.381172376652, 30957.535636965462, 31006.689933100606, 2299.6895419118373, 2330.4406942333885, 2337.5792357375667, 2341.555104530134, 2344.542814151241, 20757.584848302948, 21338.786612133834, 21707.131714731393, 21805.2368167115, 21944.45138871525, 2546.5543529882198, 2560.1679454177465, 2591.1708253358934, 2637.3406648337914, 2638.2480992916926, 138221.0, 142745.28627356797, 145472.0, 156318.21840890837, 158539.0, 16068.312827153215, 16459.25933333003, 16641.334346625998, 16803.327866885433, 16925.576860578585, 26255.343616409744, 26438.735612644014, 26485.205443836716, 26501.469970600865, 26545.867270663908, 9120.543972801333, 9152.8627070594, 9268.7682807929, 9348.672796452092, 9360.297977651568, 7911.446198766146, 7922.0, 7985.401094917905, 7985.441019128605, 8022.358211343078, 9988.950055249677, 10115.218314963444, 10121.746956326151, 10161.390316581028, 10221.74445638865, 2956.822590644568, 2959.6448426188563, 2975.4495418347674, 3011.141824579984, 3041.300500884809, 1040.490159821682, 1061.9309744866714, 1062.0919114157284, 1063.9734006649896, 1066.1896958311584, 21727.67408488874, 21886.671699924515, 21901.890490547445, 21998.670019949714, 22047.889760551094, 1083.2904447586843, 1092.470151976291, 1097.3690128176331, 1111.6665000499818, 1116.9497372618252, 11904.166708330507, 12141.878581214252, 12154.392280386122, 12256.0, 12419.254844709165, 582261.0, 590532.0, 594383.0, 599724.0, 608862.0, 128565.35717321353, 129540.0, 130482.0, 131262.0, 135236.0, 1105.8120119579692, 1157.1610582327912, 1183.4260383713893, 1199.4302706214478, 1239.7148655809215, 22665.2067177648, 23040.0, 23152.305430837103, 23174.652380213975, 23352.883235583715, 60483.697581513574, 60962.695186523786, 62091.689541552005, 63961.0, 65568.0, 77256.61371693105, 77645.61177194078, 78315.0, 78552.0, 79379.60310198412, 16066.0, 16245.67508649844, 16354.836451635332, 16441.67116657684, 16462.0, 24967.250982470556, 25220.74779252184, 25388.873055634605, 25395.746042539336, 25452.236432907044, 20163.0, 20310.492237694176, 20788.792112078685, 20847.791522084586, 21020.369388918356, 18282.268709251483, 18283.0, 18476.538086547946, 18484.075796210403, 18936.43190704281, 20432.0, 21093.628914120534, 21101.472463188544, 21136.471588210417, 21405.250816221982, 16334.591635209215, 16337.183140843148, 16434.75347869759, 16437.09595972233, 16482.598979086913, 19592.608147837247, 20223.29218477346, 20628.0, 20646.690299645215, 20667.0], "value": 12892.401007757926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.5684580934103, 1417.5463851567497, 1432.992835035825, 1437.2813593203398, 1441.4450436581913, 16786.74819877701, 17459.214335354907, 17489.475315740518, 17497.737533937, 17498.0, 17080.48758537246, 17109.743353849703, 17248.31006759731, 17261.654766904656, 17263.30946762131, 2729.113038262563, 2783.304173956511, 2834.829910205384, 2839.3895312507807, 2839.4746971810177, 2732.53546897028, 2779.7081306462833, 2791.5393959996577, 2792.0786140573664, 2794.9021784237557, 2724.2508310214653, 2737.137801592502, 2737.4935636907235, 2831.3204830840655, 2831.6460442444695, 2767.6955534891144, 2785.56823692326, 2789.7489225969557, 2799.70603086676, 2801.495730768461, 2590.8315959462575, 2598.8310759800743, 2608.79129669626, 2629.5661215899354, 2630.302969713028, 16331.591710207222, 16724.0, 16740.748888766677, 16755.162241887858, 16762.497125086265, 8164.061132969666, 8483.194096560817, 8487.660493580312, 8488.405811593191, 8494.0, 5070.619703522214, 5299.311089558333, 5382.757775900055, 5426.403095659474, 5426.701531415771, 1977.7033444983224, 2051.9487012824798, 2067.2764532413685, 2068.431181425105, 2128.7871212878745, 30113.397732045454, 30419.847900760575, 30451.847740761375, 30482.69517304843, 30521.23696907573, 7051.541649792747, 7318.194998550155, 7350.0812398449125, 7399.556026638311, 7460.328570428687, 19575.314863979977, 19577.902110489358, 19598.70601940972, 19604.901975490033, 19639.901800490905, 8287.461315014625, 8424.83150337002, 8446.282066024334, 8451.619677114544, 8458.788530286669, 7443.330100291, 7447.925520744831, 7628.084629844454, 7651.732189373345, 7733.381329493627, 5390.730463476889, 5533.723313834373, 5555.2222688823595, 5596.384397716248, 5643.661380317194, 1592.2755146408356, 1598.3287019451625, 1614.6609212065598, 1617.4714894424656, 1642.5072478256714, 801.1867954026668, 914.8307563100848, 928.2527565309855, 935.6491315756591, 956.2445667922264, 9042.18620324174, 9313.953430232805, 9381.859272110923, 9394.436333819993, 9445.386049906734, 1042.9061384475283, 1061.3737894642197, 1071.0681706914877, 1079.233744041739, 1079.6599071292517, 5599.272094627672, 5604.97197514018, 5692.943070569324, 5815.94184058154, 5914.792982245601, 23590.4102397438, 23974.0, 25146.74853251444, 25711.742882570936, 25730.6140407894, 23652.88173559121, 25205.11782087618, 25235.0, 25260.242192734248, 25273.62089568658, 11688.18182727201, 11888.227265227733, 11938.52245910154, 11974.52101915931, 12033.338166400757, 8667.609957552051, 8742.213200811957, 8823.161799629024, 8825.69110081144, 8869.157430044394, 20593.691094633894, 20810.583788324453, 21655.566888662455, 21767.78232217721, 22079.227227046977, 21543.56912861765, 21607.45981350479, 21736.782632173476, 21942.780572194075, 21957.67063494081, 12315.876841231473, 12354.938225308815, 12429.875701242872, 12430.192037517532, 12435.316057616918, 15787.368505259661, 15789.0, 15918.9204053979, 16000.0, 16037.518874433787, 12083.214591051554, 12285.1400401971, 12492.937535312265, 12520.373981301082, 12745.235285882876, 11640.301581905112, 11963.940180299043, 12013.459394327101, 12046.156769026084, 12364.258144511357, 10727.356358618508, 11015.83476247873, 11025.283356581796, 11030.613928512463, 11032.889671103187, 7988.281054705104, 8001.399895007781, 8016.83966320682, 8021.8395632088195, 8034.558099304594, 7980.760577182694, 8064.556449395105, 8163.0, 8216.589170541569, 8236.217559331853], "value": 7225.970070918369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9173623956406, 557.8772670012598, 576.437972976348, 585.6808039618408, 586.8503531599445, 5724.141378793178, 6288.402601752838, 6303.716332765025, 6314.43170114689, 6344.55588108832, 6084.72618732157, 6111.297200821907, 6233.594816336935, 6246.969250073744, 6276.435120839124, 5043.546080852722, 5045.949540504603, 5048.848534543969, 5067.467915868836, 5072.492750724917, 4888.73111978841, 4932.654714170009, 4946.230111137775, 4997.975010124945, 5014.674046187004, 4915.410150781893, 4929.728864912428, 4957.801687932479, 4979.153543897528, 5014.774335154909, 4907.92638110425, 4908.803647854082, 4959.305697202394, 4970.801167953277, 4976.278439626234, 4466.173757854807, 4504.572065653758, 4552.68131230814, 4565.863024109282, 4579.129965306614, 6191.566590338678, 6217.378262173792, 6278.937210627881, 6296.87406251877, 6306.747730090791, 5819.738111784937, 5837.6497410155525, 5881.529477641821, 5882.764689412461, 5888.499477544414, 6588.209414870246, 6593.307702691244, 6595.769148079842, 6667.0, 6678.632675202862, 4866.31871537985, 5043.344365232533, 5055.165897626887, 5086.593072554224, 5088.313077734496, 6632.801015969529, 6785.389314961628, 6797.728090876359, 6882.283566873932, 6920.30796920309, 5123.513266239701, 5134.409542902614, 5180.533751962266, 5198.16829307309, 5208.322918020709, 5282.788688452496, 5302.09864323066, 5317.468253174651, 5331.573474122061, 5332.360116785933, 5846.327672317653, 5848.649081055065, 5858.619189752652, 5869.677167755729, 5891.558133140032, 6630.138082049302, 6654.802135615636, 6696.59820410777, 6722.495812814059, 6758.83102922421, 1827.872048956587, 1831.6611426885802, 1832.1480511562188, 1832.193834712722, 1857.2570971611462, 1238.182799352423, 1287.137617796079, 1300.7723648361498, 1303.3157592264138, 1327.595083499542, 5967.587615036362, 6078.328459673625, 6151.692415379213, 6172.5679202456295, 6187.288461826947, 6534.607923524603, 6572.408483236436, 6587.308332625005, 6667.19993600771, 6763.830904227335, 5999.310079340845, 6080.331163572092, 6178.042403427476, 6233.407826256498, 6272.6236425814595, 3569.5538057742783, 3596.3166998270244, 3604.873829415958, 3619.529461170084, 3626.476879710528, 6756.290589488131, 6789.558678685869, 6824.965875170592, 6844.555103918329, 6902.827429314207, 6975.267596902252, 7029.472789540702, 7066.964665176744, 7095.3968912643, 7111.679974401164, 7009.1589009319205, 7027.472939529555, 7041.225465198926, 7044.577325360495, 7057.7176912922905, 6641.236257830218, 6749.730010799513, 6771.695273712597, 6812.96593517049, 6818.284080171709, 6563.540552161303, 6626.403623673892, 6626.56927299724, 6762.357576030269, 6763.0, 6779.220389655253, 6797.320267973361, 6816.807058764795, 6829.74109935337, 6833.965830170818, 5171.120909445479, 5212.0878846201, 5214.217867319932, 5214.374275087014, 5251.133562962068, 6600.966995164993, 6604.768833090819, 6626.337366263335, 6770.322967703387, 6799.898001529882, 6414.390632889868, 6493.577917435352, 6571.145751052332, 6594.406503414716, 6692.799216023527, 6424.93575064262, 6505.544611877123, 6518.511111666549, 6608.306127856506, 6644.069830223869, 6543.312952139957, 6557.655680585373, 6580.736770529125, 6580.967095164494, 6610.933890661224, 6671.232808226922, 6685.799426017227, 6715.764948226789, 6716.1604799400075, 6775.830604234933, 6457.354264573505, 6461.61230326182, 6461.741530338733, 6491.188601424822, 6552.8361790955605], "value": 5179.5485775479565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [976.2287792643812, 990.8563258327542, 1010.171659239424, 1011.448760425568, 1020.6835880876929, 18459.0, 18812.34156804512, 18822.153003114858, 18889.811101888976, 20458.283960061402, 19567.412977610693, 19684.0, 19730.605387892232, 19753.901230493862, 19756.30852920148, 1019.5208252121491, 1044.937303761773, 1049.0715716590835, 1050.396022287184, 1050.837120246363, 1049.3441599000626, 1064.978700425991, 1067.386252904583, 1068.647346375694, 1069.3049517813406, 1064.7710742190427, 1115.871674757401, 1117.972050698731, 1118.546988469671, 1130.7229728716477, 1098.0940723902772, 1104.1829046505609, 1106.4854842498278, 1106.7675788084512, 1109.3343993603814, 795.6499140378215, 810.8783682447621, 815.0667485728867, 817.4237162800212, 819.0949001353479, 21066.0, 21393.25123620666, 21398.679019814714, 21398.679019814714, 21458.892705536528, 22525.0, 23005.76994230053, 23184.65223021656, 23551.29346119619, 23557.29328120159, 17146.57133571658, 17358.82641173585, 17470.126493675394, 17768.822311776847, 17787.19957601911, 3947.0921688011917, 3978.6021397860272, 3979.0, 3981.7610943343493, 3983.8406463741417, 130642.0, 157195.0, 157885.0, 158632.20683896623, 161308.99999999884, 18793.15430805617, 18880.24479020824, 18930.148143333583, 18972.241110355706, 18979.90510047441, 34486.965391038306, 34700.82649586786, 35276.47085293723, 35404.0, 35635.0, 9781.119699227103, 9794.412335259907, 9837.901620983841, 9878.160356369644, 9899.752506187402, 4389.429374181336, 4407.052483715952, 4490.685652004328, 4491.214037543416, 4507.774611269423, 5798.478136967693, 5912.3496415394275, 5916.1421593868645, 5929.258842644669, 5947.04847224442, 1217.1297522271618, 1239.3431481314917, 1241.1684171604866, 1243.3339325304137, 1263.9873601263869, 726.4551586310267, 744.7244519527809, 746.145663215626, 763.3969164360093, 763.8395936853212, 13403.396847141901, 13798.17210967345, 13810.37853296584, 14127.505537306144, 14187.290635468185, 697.7836870570038, 708.9896896921865, 714.9177844547944, 722.4978639845257, 723.1286300008477, 5779.133130030445, 5815.709214539256, 5847.26909136358, 5852.297724273115, 5945.078512830518, 140657.0, 142188.0, 147392.0, 147765.0, 147781.0, 104072.0, 126701.36649316695, 130063.0, 130744.0, 134547.0, 112261.43869280601, 112585.0, 112889.43555282171, 114487.0, 121734.8270121928, 13875.375608097458, 14539.41842326295, 14600.926995364955, 14606.26968651542, 14681.41274349014, 55226.0, 55390.44609553853, 55485.0, 55673.44326556844, 55813.441865580826, 71672.0, 73567.0, 73787.0, 73929.6303518479, 74445.62777186296, 20466.795332046488, 21003.73977561351, 21096.683549747075, 21197.7880221202, 21277.148914043264, 21852.78147218571, 22389.104435822384, 22422.887885561122, 22446.0, 22642.886785565966, 20627.278045268344, 20628.381148565568, 20710.896445517676, 20760.273390431263, 20845.895770521656, 16955.576110597332, 17028.659426811642, 17102.0, 17218.483445496655, 17300.394486192923, 20763.0, 20830.687539686613, 20947.8952605236, 21114.944252787605, 21278.680819788024, 13360.799588005993, 13553.186808791505, 13605.86394136046, 13668.52160174389, 13905.721885562434, 15574.299156538209, 15700.92149539245, 15830.050196987757, 16051.839481605502, 16117.0], "value": 10179.014412596252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1372.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 105.0, 107.0, 106.0, 106.0, 117.0, 107.0, 104.0, 105.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 111.0, 143.0, 115.0, 115.0, 123.0, 113.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 165.0, 161.0, 161.0, 160.0, 163.0, 161.0, 167.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 71.0, 72.0, 74.0, 74.0, 74.0, 74.0, 75.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 80.0, 77.0, 78.0, 77.0, 78.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 109.0, 114.0, 114.0, 111.0, 116.0, 115.0, 115.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 149.0, 150.0, 149.0, 149.0, 150.0, 150.0, 152.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 93.0, 95.0, 93.0, 95.0, 94.0, 95.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 46.0, 44.0, 45.0, 45.0, 45.0, 44.0, 44.0, 43.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 37.0, 38.0, 41.0, 37.0, 37.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 72.0, 73.0, 74.0, 70.0, 72.0, 75.0, 73.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 102.0, 110.0, 107.0, 111.0, 106.0, 106.0, 109.0, 102.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 149.0, 150.0, 151.0, 153.0, 150.0, 160.0, 153.0, 152.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 58.0, 59.0, 64.0, 62.0, 61.0, 70.0, 63.0, 62.0], "value": 62.8, "unit": "score"}]}]} 12:04:48 INFO - Return code: 0 12:04:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:04:48 INFO - # TBPL SUCCESS # 12:04:48 INFO - Running post-action listener: _package_coverage_data 12:04:48 INFO - Running post-action listener: _resource_record_post_action 12:04:48 INFO - [mozharness: 2017-09-20 19:04:48.894530Z] Finished run-tests step (success) 12:04:48 INFO - Running post-run listener: _resource_record_post_run 12:04:48 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 339210240; Read time: 268; Write time: 240664 12:04:48 INFO - TinderboxPrint: CPU usage
13.1% 12:04:48 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 268 12:04:48 INFO - TinderboxPrint: I/O write bytes / time
339,210,240 / 240,664 12:04:48 INFO - TinderboxPrint: CPU idle
8,219.4 (86.9%) 12:04:48 INFO - TinderboxPrint: CPU user
1,186.6 (12.5%) 12:04:48 INFO - TinderboxPrint: Swap in / out
0 / 0 12:04:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13025280; Read time: 0; Write time: 2108 12:04:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:04:48 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 16384; Write bytes: 326184960; Read time: 268; Write time: 238556 12:04:49 INFO - Running post-run listener: _upload_blobber_files 12:04:49 INFO - Blob upload gear active. 12:04:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:04:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:04:49 INFO - (blobuploader) - INFO - Open directory for files ... 12:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:51 INFO - (blobuploader) - INFO - Done attempting. 12:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:52 INFO - (blobuploader) - INFO - Done attempting. 12:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:52 INFO - (blobuploader) - INFO - Done attempting. 12:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:04:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:04:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:04:59 INFO - (blobuploader) - INFO - Done attempting. 12:04:59 INFO - (blobuploader) - INFO - Iteration through files over. 12:04:59 INFO - Return code: 0 12:04:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:04:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:04:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0553503d0b7c4e6a2f914b782cd28c05a6534ea5930361235714329a0a5a6a383b44431f2219d9202588b6c06ed3878d0525d41e597b9de28a92432a35352b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/269d5133c0317014ba1c16c7aa6bd667bb98c772a0479da187577fd906f896694bd5a5e4796211a932a175ab0f07607ee8ee6795faca8d607c36414d8654f478", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5d58226bdbd4d12a7d69e24936223002490c27a4a0908a535fdcd72f8104bc1a24e71a24675b6aa09d8fd9bbf47b307283439c8e7c5516ff7b3a4dd324f03d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e0ff87438ca76ad1dad8fae5ffbe10766c70e91855f7edc57828bf9463351d2cadd5faf28dcb1f0c2a0171917b38c66f68dfddeb3fd805c25bafbdb52c58e7b"} 12:04:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:04:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:04:59 INFO - Contents: 12:04:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0553503d0b7c4e6a2f914b782cd28c05a6534ea5930361235714329a0a5a6a383b44431f2219d9202588b6c06ed3878d0525d41e597b9de28a92432a35352b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/269d5133c0317014ba1c16c7aa6bd667bb98c772a0479da187577fd906f896694bd5a5e4796211a932a175ab0f07607ee8ee6795faca8d607c36414d8654f478", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5d58226bdbd4d12a7d69e24936223002490c27a4a0908a535fdcd72f8104bc1a24e71a24675b6aa09d8fd9bbf47b307283439c8e7c5516ff7b3a4dd324f03d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e0ff87438ca76ad1dad8fae5ffbe10766c70e91855f7edc57828bf9463351d2cadd5faf28dcb1f0c2a0171917b38c66f68dfddeb3fd805c25bafbdb52c58e7b"} 12:04:59 INFO - Running post-run listener: copy_logs_to_upload_dir 12:04:59 INFO - Copying logs to upload dir... 12:04:59 INFO - mkdir: /builds/slave/test/build/upload/logs 12:04:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.053821 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-20 12:05:00.212797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:00.219460) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 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/bd0553503d0b7c4e6a2f914b782cd28c05a6534ea5930361235714329a0a5a6a383b44431f2219d9202588b6c06ed3878d0525d41e597b9de28a92432a35352b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/269d5133c0317014ba1c16c7aa6bd667bb98c772a0479da187577fd906f896694bd5a5e4796211a932a175ab0f07607ee8ee6795faca8d607c36414d8654f478", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5d58226bdbd4d12a7d69e24936223002490c27a4a0908a535fdcd72f8104bc1a24e71a24675b6aa09d8fd9bbf47b307283439c8e7c5516ff7b3a4dd324f03d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e0ff87438ca76ad1dad8fae5ffbe10766c70e91855f7edc57828bf9463351d2cadd5faf28dcb1f0c2a0171917b38c66f68dfddeb3fd805c25bafbdb52c58e7b"} build_url:https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/aIA_GDTzSB6yAt1pcYj2gA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0553503d0b7c4e6a2f914b782cd28c05a6534ea5930361235714329a0a5a6a383b44431f2219d9202588b6c06ed3878d0525d41e597b9de28a92432a35352b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/269d5133c0317014ba1c16c7aa6bd667bb98c772a0479da187577fd906f896694bd5a5e4796211a932a175ab0f07607ee8ee6795faca8d607c36414d8654f478", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b5d58226bdbd4d12a7d69e24936223002490c27a4a0908a535fdcd72f8104bc1a24e71a24675b6aa09d8fd9bbf47b307283439c8e7c5516ff7b3a4dd324f03d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e0ff87438ca76ad1dad8fae5ffbe10766c70e91855f7edc57828bf9463351d2cadd5faf28dcb1f0c2a0171917b38c66f68dfddeb3fd805c25bafbdb52c58e7b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:00.256419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:00.256740) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1505932892.148616-1684775536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 12:05:00.346348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 12:05:00.346667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 12:05:00.347009) ========= ========= Total master_lag: 0.33 =========