builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1504953347.83 results: success (0) revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:47.828398) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:47.828791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:47.829060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:47.889621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:47.893987) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 03:35:48-- 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% 50.3M=0s 2017-09-09 03:35:48 (50.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182044 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:48.101855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:48.102141) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:48.153823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 03:35:48.154139) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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 e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 --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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 03:35:48,424 truncating revision to first 12 chars 2017-09-09 03:35:48,424 Setting DEBUG logging. 2017-09-09 03:35:48,424 attempt 1/10 2017-09-09 03:35:48,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0d88cd771d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 03:35:49,574 unpacking tar archive at: mozilla-central-e0d88cd771d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.489314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 03:35:49.663056) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:49.663414) ========= script_repo_revision: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:49.663835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:49.664114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 03:35:49.677658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-09 03:35:49.678092) ========= /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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:50 INFO - MultiFileLogger online at 20170909 03:35:50 in /builds/slave/test 03:35:50 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 03:35:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:50 INFO - {'append_to_log': False, 03:35:50 INFO - 'base_work_dir': '/builds/slave/test', 03:35:50 INFO - 'blob_upload_branch': 'Firefox', 03:35:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:50 INFO - 'branch': 'Firefox', 03:35:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:50 INFO - 'code_coverage': False, 03:35:50 INFO - 'config_files': ('talos/linux_config.py',), 03:35:50 INFO - 'default_actions': ('clobber', 03:35:50 INFO - 'read-buildbot-config', 03:35:50 INFO - 'download-and-extract', 03:35:50 INFO - 'populate-webroot', 03:35:50 INFO - 'create-virtualenv', 03:35:50 INFO - 'install', 03:35:50 INFO - 'setup-mitmproxy', 03:35:50 INFO - 'run-tests'), 03:35:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:50 INFO - 'disable_ccov_upload': False, 03:35:50 INFO - 'disable_stylo': False, 03:35:50 INFO - 'download_minidump_stackwalk': True, 03:35:50 INFO - 'download_symbols': 'ondemand', 03:35:50 INFO - 'enable_stylo': False, 03:35:50 INFO - 'enable_webrender': False, 03:35:50 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:35:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:50 INFO - 'gecko_profile': False, 03:35:50 INFO - 'gecko_profile_interval': 0, 03:35:50 INFO - 'installer_path': 'installer.exe', 03:35:50 INFO - 'log_level': 'info', 03:35:50 INFO - 'log_name': 'talos', 03:35:50 INFO - 'log_to_console': True, 03:35:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:50 INFO - 'opt_config_files': (), 03:35:50 INFO - 'pip_index': False, 03:35:50 INFO - 'suite': 'dromaeojs-e10s', 03:35:50 INFO - 'system_bits': '32', 03:35:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:50 INFO - 'title': 'talos-linux64-ix-011', 03:35:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:50 INFO - 'use_talos_json': True, 03:35:50 INFO - 'verify': 'False', 03:35:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:50 INFO - 'work_dir': 'build'} 03:35:50 INFO - [mozharness: 2017-09-09 10:35:50.080818Z] Running clobber step. 03:35:50 INFO - Running pre-action listener: _resource_record_pre_action 03:35:50 INFO - Running main action method: clobber 03:35:50 INFO - rmtree: /builds/slave/test/build 03:35:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:51 INFO - Running post-action listener: _resource_record_post_action 03:35:51 INFO - [mozharness: 2017-09-09 10:35:51.607101Z] Finished clobber step (success) 03:35:51 INFO - [mozharness: 2017-09-09 10:35:51.607203Z] Running read-buildbot-config step. 03:35:51 INFO - Running pre-action listener: _resource_record_pre_action 03:35:51 INFO - Running main action method: read_buildbot_config 03:35:51 INFO - Using buildbot properties: 03:35:51 INFO - { 03:35:51 INFO - "project": "", 03:35:51 INFO - "product": "firefox", 03:35:51 INFO - "who": "archaeopteryx@coole-files.de", 03:35:51 INFO - "installer_path": "public/build/target.tar.bz2", 03:35:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:35:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:35:51 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:35:51 INFO - "stage_platform": "linux64-qr", 03:35:51 INFO - "basedir": "/builds/slave/test", 03:35:51 INFO - "buildnumber": 41, 03:35:51 INFO - "platform": "ubuntu64_hw_qr", 03:35:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:35:51 INFO - "slavebuilddir": "test", 03:35:51 INFO - "taskId": "DKAB6ZqLRCGfJW44yCZ3fA", 03:35:51 INFO - "branch": "mozilla-central", 03:35:51 INFO - "script_repo_revision": "production", 03:35:51 INFO - "revision": "e0d88cd771d6791be4eaed4ada9315f4b26e2ad1", 03:35:51 INFO - "slavename": "talos-linux64-ix-011", 03:35:51 INFO - "repo_path": "mozilla-central" 03:35:51 INFO - } 03:35:51 INFO - Finding installer, test and symbols from parent task. 03:35:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DKAB6ZqLRCGfJW44yCZ3fA'}, attempt #1 03:35:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DKAB6ZqLRCGfJW44yCZ3fA'}, attempt #1 03:35:52 INFO - Task dependencies: NAT5dUiYQCyr_at2cW6x4A 03:35:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A'}, attempt #1 03:35:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 03:35:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.test_packages.json 03:35:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.crashreporter-symbols.zip 03:35:52 INFO - Running post-action listener: _resource_record_post_action 03:35:52 INFO - [mozharness: 2017-09-09 10:35:52.946630Z] Finished read-buildbot-config step (success) 03:35:52 INFO - [mozharness: 2017-09-09 10:35:52.946879Z] Running download-and-extract step. 03:35:52 INFO - Running pre-action listener: _resource_record_pre_action 03:35:52 INFO - Running main action method: download_and_extract 03:35:52 INFO - mkdir: /builds/slave/test/build/tests 03:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:52 INFO - trying https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.test_packages.json 03:35:52 INFO - Downloading https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:35:53 INFO - Downloaded 989 bytes. 03:35:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:35:53 INFO - Using the following test package requirements: 03:35:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:35:53 INFO - u'common': [u'target.common.tests.zip'], 03:35:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:35:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:35:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:35:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:35:53 INFO - u'mozbase': [u'target.common.tests.zip'], 03:35:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:35:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:35:53 INFO - u'web-platform': [u'target.common.tests.zip', 03:35:53 INFO - u'target.web-platform.tests.tar.gz'], 03:35:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:35:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:35:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.common.tests.zip 03:35:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:35:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.common.tests.zip into memory 03:35:54 INFO - Content-Length response header: 55024761 03:35:54 INFO - Bytes received: 55024761 03:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.talos.tests.zip 03:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.talos.tests.zip into memory 03:36:06 INFO - Content-Length response header: 14497963 03:36:06 INFO - Bytes received: 14497963 03:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:06 INFO - trying https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 03:36:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:36:07 INFO - Downloaded 62862800 bytes. 03:36:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 03:36:08 INFO - mkdir: /builds/slave/test/properties 03:36:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:08 INFO - Contents: 03:36:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 03:36:08 INFO - Running post-action listener: _resource_record_post_action 03:36:08 INFO - Running post-action listener: find_tests_for_verification 03:36:08 INFO - Running post-action listener: set_extra_try_arguments 03:36:08 INFO - [mozharness: 2017-09-09 10:36:08.022097Z] Finished download-and-extract step (success) 03:36:08 INFO - [mozharness: 2017-09-09 10:36:08.022198Z] Running populate-webroot step. 03:36:08 INFO - Running pre-action listener: _resource_record_pre_action 03:36:08 INFO - Running main action method: populate_webroot 03:36:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:08 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['tresize', 03:36:08 INFO - 'tcanvasmark']}, 03:36:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:08 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['dromaeo_css', 03:36:08 INFO - 'kraken']}, 03:36:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:08 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'tests': ['damp', 'tps']}, 03:36:08 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['damp', 'tps']}, 03:36:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:08 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['dromaeo_dom']}, 03:36:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:36:08 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['basic_compositor_video', 03:36:08 INFO - 'glvideo']}, 03:36:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:36:08 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['ts_paint_webext', 03:36:08 INFO - 'tp5o_webext']}, 03:36:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:08 INFO - 'ts_paint', 03:36:08 INFO - 'tpaint', 03:36:08 INFO - 'sessionrestore', 03:36:08 INFO - 'sessionrestore_many_windows', 03:36:08 INFO - 'sessionrestore_no_auto_restore', 03:36:08 INFO - 'tabpaint']}, 03:36:08 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['a11yr', 03:36:08 INFO - 'ts_paint', 03:36:08 INFO - 'tpaint', 03:36:08 INFO - 'sessionrestore', 03:36:08 INFO - 'sessionrestore_many_windows', 03:36:08 INFO - 'sessionrestore_no_auto_restore', 03:36:08 INFO - 'tabpaint']}, 03:36:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:36:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:36:08 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['bloom_basic_singleton']}, 03:36:08 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['bloom_basic']}, 03:36:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:08 INFO - 'tsvgr_opacity', 03:36:08 INFO - 'tart', 03:36:08 INFO - 'tscrollx', 03:36:08 INFO - 'tsvg_static']}, 03:36:08 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['tsvgx', 03:36:08 INFO - 'tsvgr_opacity', 03:36:08 INFO - 'tart', 03:36:08 INFO - 'tscrollx', 03:36:08 INFO - 'tsvg_static']}, 03:36:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:36:08 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo'], 03:36:08 INFO - 'tests': ['tp5o']}, 03:36:08 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:08 INFO - 'talos_options': ['--mitmproxy', 03:36:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:08 INFO - '--firstNonBlankPaint'], 03:36:08 INFO - 'tests': ['tp6_google', 03:36:08 INFO - 'tp6_youtube', 03:36:08 INFO - 'tp6_amazon', 03:36:08 INFO - 'tp6_facebook']}, 03:36:08 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo', 03:36:08 INFO - '--mitmproxy', 03:36:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:08 INFO - '--firstNonBlankPaint'], 03:36:08 INFO - 'tests': ['tp6_google', 03:36:08 INFO - 'tp6_youtube', 03:36:08 INFO - 'tp6_amazon', 03:36:08 INFO - 'tp6_facebook']}, 03:36:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:08 INFO - 'talos_options': ['--stylo-threads=1', 03:36:08 INFO - '--mitmproxy', 03:36:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:08 INFO - '--firstNonBlankPaint'], 03:36:08 INFO - 'tests': ['tp6_google', 03:36:08 INFO - 'tp6_youtube', 03:36:08 INFO - 'tp6_amazon', 03:36:08 INFO - 'tp6_facebook']}, 03:36:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--xperf_path', 03:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:08 INFO - 'tests': ['tp5n']}, 03:36:08 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:08 INFO - 'talos_options': ['--disable-stylo', 03:36:08 INFO - '--xperf_path', 03:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:08 INFO - 'tests': ['tp5n']}}} 03:36:08 INFO - Running post-action listener: _resource_record_post_action 03:36:08 INFO - [mozharness: 2017-09-09 10:36:08.038430Z] Finished populate-webroot step (success) 03:36:08 INFO - [mozharness: 2017-09-09 10:36:08.038536Z] Running create-virtualenv step. 03:36:08 INFO - Running pre-action listener: _resource_record_pre_action 03:36:08 INFO - Running main action method: create_virtualenv 03:36:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:08 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:36:08 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:36:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:36:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:10 INFO - Installing pip...............done. 03:36:10 INFO - Return code: 0 03:36:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:10 INFO - Reading from file tmpfile_stdout 03:36:10 INFO - Output received: 03:36:10 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:36:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:10 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:10 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 03:36:10 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 03:36:10 INFO - Using env: {'DISPLAY': ':0', 03:36:10 INFO - 'HOME': '/home/cltbld', 03:36:10 INFO - 'LANG': 'en_US.UTF-8', 03:36:10 INFO - 'LANGUAGE': 'en_US:en', 03:36:10 INFO - 'LOGNAME': 'cltbld', 03:36:10 INFO - 'MAIL': '/var/mail/cltbld', 03:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:10 INFO - 'MOZ_NO_REMOTE': '1', 03:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:10 INFO - 'NO_EM_RESTART': '1', 03:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:10 INFO - 'PWD': '/builds/slave/test', 03:36:10 INFO - 'SHELL': '/bin/bash', 03:36:10 INFO - 'SHLVL': '1', 03:36:10 INFO - 'TERM': 'linux', 03:36:10 INFO - 'TMOUT': '86400', 03:36:10 INFO - 'USER': 'cltbld', 03:36:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:10 INFO - '_': '/tools/buildbot/bin/python'} 03:36:11 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:36:11 INFO - Downloading/unpacking pip>=1.5 03:36:11 INFO - Running setup.py egg_info for package pip 03:36:11 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:11 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:11 INFO - Installing collected packages: pip 03:36:11 INFO - Found existing installation: pip 1.1 03:36:11 INFO - Uninstalling pip: 03:36:11 INFO - Successfully uninstalled pip 03:36:11 INFO - Running setup.py install for pip 03:36:11 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:11 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:11 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:36:11 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:36:11 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:36:11 INFO - Successfully installed pip 03:36:11 INFO - Cleaning up... 03:36:11 INFO - Return code: 0 03:36:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:11 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:11 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 03:36:11 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 03:36:11 INFO - Using env: {'DISPLAY': ':0', 03:36:11 INFO - 'HOME': '/home/cltbld', 03:36:11 INFO - 'LANG': 'en_US.UTF-8', 03:36:11 INFO - 'LANGUAGE': 'en_US:en', 03:36:11 INFO - 'LOGNAME': 'cltbld', 03:36:11 INFO - 'MAIL': '/var/mail/cltbld', 03:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:11 INFO - 'MOZ_NO_REMOTE': '1', 03:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:11 INFO - 'NO_EM_RESTART': '1', 03:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:11 INFO - 'PWD': '/builds/slave/test', 03:36:11 INFO - 'SHELL': '/bin/bash', 03:36:11 INFO - 'SHLVL': '1', 03:36:11 INFO - 'TERM': 'linux', 03:36:11 INFO - 'TMOUT': '86400', 03:36:11 INFO - 'USER': 'cltbld', 03:36:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:11 INFO - '_': '/tools/buildbot/bin/python'} 03:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:11 INFO - Downloading/unpacking psutil>=3.1.1 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:13 INFO - Installing collected packages: psutil 03:36:13 INFO - Running setup.py install for psutil 03:36:13 INFO - building 'psutil._psutil_linux' extension 03:36:13 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 03:36:13 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 03:36:13 INFO - building 'psutil._psutil_posix' extension 03:36:13 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 03:36:13 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 03:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:13 INFO - Successfully installed psutil 03:36:13 INFO - Cleaning up... 03:36:13 INFO - Return code: 0 03:36:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:13 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')]} 03:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:13 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')]} 03:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:13 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:13 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 03:36:13 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 03:36:13 INFO - Using env: {'DISPLAY': ':0', 03:36:13 INFO - 'HOME': '/home/cltbld', 03:36:13 INFO - 'LANG': 'en_US.UTF-8', 03:36:13 INFO - 'LANGUAGE': 'en_US:en', 03:36:13 INFO - 'LOGNAME': 'cltbld', 03:36:13 INFO - 'MAIL': '/var/mail/cltbld', 03:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:13 INFO - 'MOZ_NO_REMOTE': '1', 03:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:13 INFO - 'NO_EM_RESTART': '1', 03:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:13 INFO - 'PWD': '/builds/slave/test', 03:36:13 INFO - 'SHELL': '/bin/bash', 03:36:13 INFO - 'SHLVL': '1', 03:36:13 INFO - 'TERM': 'linux', 03:36:13 INFO - 'TMOUT': '86400', 03:36:13 INFO - 'USER': 'cltbld', 03:36:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:13 INFO - '_': '/tools/buildbot/bin/python'} 03:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:13 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 03:36:13 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 03:36:13 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 03:36:13 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 03:36:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:15 INFO - Installing collected packages: mozsystemmonitor 03:36:15 INFO - Running setup.py install for mozsystemmonitor 03:36:15 INFO - Successfully installed mozsystemmonitor 03:36:15 INFO - Cleaning up... 03:36:16 INFO - Return code: 0 03:36:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:16 INFO - Using env: {'DISPLAY': ':0', 03:36:16 INFO - 'HOME': '/home/cltbld', 03:36:16 INFO - 'LANG': 'en_US.UTF-8', 03:36:16 INFO - 'LANGUAGE': 'en_US:en', 03:36:16 INFO - 'LOGNAME': 'cltbld', 03:36:16 INFO - 'MAIL': '/var/mail/cltbld', 03:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:16 INFO - 'MOZ_NO_REMOTE': '1', 03:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:16 INFO - 'NO_EM_RESTART': '1', 03:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:16 INFO - 'PWD': '/builds/slave/test', 03:36:16 INFO - 'SHELL': '/bin/bash', 03:36:16 INFO - 'SHLVL': '1', 03:36:16 INFO - 'TERM': 'linux', 03:36:16 INFO - 'TMOUT': '86400', 03:36:16 INFO - 'USER': 'cltbld', 03:36:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:16 INFO - '_': '/tools/buildbot/bin/python'} 03:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:17 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:18 INFO - warning: no files found matching '*.txt' 03:36:18 INFO - no previously-included directories found matching 'build' 03:36:18 INFO - no previously-included directories found matching 'dist' 03:36:18 INFO - no previously-included directories found matching '.git*' 03:36:18 INFO - Installing collected packages: jsonschema, functools32 03:36:18 INFO - Running setup.py install for functools32 03:36:18 INFO - warning: no files found matching '*.txt' 03:36:18 INFO - no previously-included directories found matching 'build' 03:36:18 INFO - no previously-included directories found matching 'dist' 03:36:18 INFO - no previously-included directories found matching '.git*' 03:36:18 INFO - Successfully installed jsonschema functools32 03:36:18 INFO - Cleaning up... 03:36:18 INFO - Return code: 0 03:36:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:18 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:18 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 03:36:18 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 03:36:18 INFO - Using env: {'DISPLAY': ':0', 03:36:18 INFO - 'HOME': '/home/cltbld', 03:36:18 INFO - 'LANG': 'en_US.UTF-8', 03:36:18 INFO - 'LANGUAGE': 'en_US:en', 03:36:18 INFO - 'LOGNAME': 'cltbld', 03:36:18 INFO - 'MAIL': '/var/mail/cltbld', 03:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:18 INFO - 'MOZ_NO_REMOTE': '1', 03:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:18 INFO - 'NO_EM_RESTART': '1', 03:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:18 INFO - 'PWD': '/builds/slave/test', 03:36:18 INFO - 'SHELL': '/bin/bash', 03:36:18 INFO - 'SHLVL': '1', 03:36:18 INFO - 'TERM': 'linux', 03:36:18 INFO - 'TMOUT': '86400', 03:36:18 INFO - 'USER': 'cltbld', 03:36:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:18 INFO - '_': '/tools/buildbot/bin/python'} 03:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:19 INFO - Cleaning up... 03:36:19 INFO - Return code: 0 03:36:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:19 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')]} 03:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:19 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')]} 03:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:19 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:19 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 03:36:19 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 03:36:19 INFO - Using env: {'DISPLAY': ':0', 03:36:19 INFO - 'HOME': '/home/cltbld', 03:36:19 INFO - 'LANG': 'en_US.UTF-8', 03:36:19 INFO - 'LANGUAGE': 'en_US:en', 03:36:19 INFO - 'LOGNAME': 'cltbld', 03:36:19 INFO - 'MAIL': '/var/mail/cltbld', 03:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:19 INFO - 'MOZ_NO_REMOTE': '1', 03:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:19 INFO - 'NO_EM_RESTART': '1', 03:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:19 INFO - 'PWD': '/builds/slave/test', 03:36:19 INFO - 'SHELL': '/bin/bash', 03:36:19 INFO - 'SHLVL': '1', 03:36:19 INFO - 'TERM': 'linux', 03:36:19 INFO - 'TMOUT': '86400', 03:36:19 INFO - 'USER': 'cltbld', 03:36:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:19 INFO - '_': '/tools/buildbot/bin/python'} 03:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:19 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:19 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 03:36:19 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 03:36:19 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 03:36:19 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 03:36:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 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 03:36:20 INFO - Downloading docopt-0.6.1.tar.gz 03:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:20 INFO - Running setup.py install for blobuploader 03:36:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:21 INFO - Running setup.py install for requests 03:36:21 INFO - Running setup.py install for docopt 03:36:21 INFO - Successfully installed blobuploader requests docopt 03:36:21 INFO - Cleaning up... 03:36:21 INFO - Return code: 0 03:36:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:21 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:21 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 03:36:21 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 03:36:21 INFO - Using env: {'DISPLAY': ':0', 03:36:21 INFO - 'HOME': '/home/cltbld', 03:36:21 INFO - 'LANG': 'en_US.UTF-8', 03:36:21 INFO - 'LANGUAGE': 'en_US:en', 03:36:21 INFO - 'LOGNAME': 'cltbld', 03:36:21 INFO - 'MAIL': '/var/mail/cltbld', 03:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:21 INFO - 'MOZ_NO_REMOTE': '1', 03:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:21 INFO - 'NO_EM_RESTART': '1', 03:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:21 INFO - 'PWD': '/builds/slave/test', 03:36:21 INFO - 'SHELL': '/bin/bash', 03:36:21 INFO - 'SHLVL': '1', 03:36:21 INFO - 'TERM': 'linux', 03:36:21 INFO - 'TMOUT': '86400', 03:36:21 INFO - 'USER': 'cltbld', 03:36:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:21 INFO - '_': '/tools/buildbot/bin/python'} 03:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:21 INFO - Running setup.py (path:/tmp/pip-A6iKsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:21 INFO - Running setup.py (path:/tmp/pip-AWnpx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:21 INFO - Running setup.py (path:/tmp/pip-3ZUKdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:21 INFO - Running setup.py (path:/tmp/pip-Nk8cx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:22 INFO - Running setup.py (path:/tmp/pip-Q3Kg31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:22 INFO - Running setup.py (path:/tmp/pip-8Udcte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:22 INFO - Running setup.py (path:/tmp/pip-Wqjd1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:22 INFO - Running setup.py (path:/tmp/pip-dxprhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:22 INFO - Running setup.py (path:/tmp/pip-f7fQeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:22 INFO - Running setup.py (path:/tmp/pip-2nkUTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:22 INFO - Running setup.py (path:/tmp/pip-SRMYdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:22 INFO - Running setup.py (path:/tmp/pip-RBxP9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:22 INFO - Running setup.py (path:/tmp/pip-RkOhkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:22 INFO - Running setup.py (path:/tmp/pip-L8fGvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:22 INFO - Running setup.py (path:/tmp/pip-DTT4mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:22 INFO - Running setup.py (path:/tmp/pip-gyFLSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:22 INFO - Running setup.py (path:/tmp/pip-ZqVbz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:22 INFO - Running setup.py install for manifestparser 03:36:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozcrash 03:36:23 INFO - Running setup.py install for mozdebug 03:36:23 INFO - Running setup.py install for mozdevice 03:36:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozfile 03:36:23 INFO - Running setup.py install for mozhttpd 03:36:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozinfo 03:36:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozInstall 03:36:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozleak 03:36:23 INFO - Running setup.py install for mozlog 03:36:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for moznetwork 03:36:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Running setup.py install for mozprocess 03:36:24 INFO - Running setup.py install for mozprofile 03:36:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Running setup.py install for mozrunner 03:36:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Running setup.py install for mozscreenshot 03:36:24 INFO - Running setup.py install for moztest 03:36:24 INFO - Running setup.py install for mozversion 03:36:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:24 INFO - Cleaning up... 03:36:24 INFO - Return code: 0 03:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:24 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')]} 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:24 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')]} 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:24 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:24 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 03:36:24 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 03:36:24 INFO - Using env: {'DISPLAY': ':0', 03:36:24 INFO - 'HOME': '/home/cltbld', 03:36:24 INFO - 'LANG': 'en_US.UTF-8', 03:36:24 INFO - 'LANGUAGE': 'en_US:en', 03:36:24 INFO - 'LOGNAME': 'cltbld', 03:36:24 INFO - 'MAIL': '/var/mail/cltbld', 03:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:24 INFO - 'MOZ_NO_REMOTE': '1', 03:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:24 INFO - 'NO_EM_RESTART': '1', 03:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:24 INFO - 'PWD': '/builds/slave/test', 03:36:24 INFO - 'SHELL': '/bin/bash', 03:36:24 INFO - 'SHLVL': '1', 03:36:24 INFO - 'TERM': 'linux', 03:36:24 INFO - 'TMOUT': '86400', 03:36:24 INFO - 'USER': 'cltbld', 03:36:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:24 INFO - '_': '/tools/buildbot/bin/python'} 03:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:24 INFO - Running setup.py (path:/tmp/pip-ulQnb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:25 INFO - Running setup.py (path:/tmp/pip-j3jmbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:25 INFO - Running setup.py (path:/tmp/pip-QbNFg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:25 INFO - Running setup.py (path:/tmp/pip-ZtT345-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:25 INFO - Running setup.py (path:/tmp/pip-yVJFlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:25 INFO - Running setup.py (path:/tmp/pip-6hesN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:25 INFO - Running setup.py (path:/tmp/pip-2OWJdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:25 INFO - Running setup.py (path:/tmp/pip-zSW6Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:25 INFO - Running setup.py (path:/tmp/pip-f21yLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:25 INFO - Running setup.py (path:/tmp/pip-OjWr9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:25 INFO - Running setup.py (path:/tmp/pip-_B8gGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:25 INFO - Running setup.py (path:/tmp/pip-el3QdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:25 INFO - Running setup.py (path:/tmp/pip-us2NJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:25 INFO - Running setup.py (path:/tmp/pip-d99TCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:25 INFO - Running setup.py (path:/tmp/pip-4ZYB9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:26 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)) 03:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:26 INFO - Running setup.py (path:/tmp/pip-haDOih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:26 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)) 03:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:26 INFO - Running setup.py (path:/tmp/pip-mcbjiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:26 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 03:36:26 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 03:36:26 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 03:36:26 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 03:36:27 INFO - Downloading blessings-1.6.tar.gz 03:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:27 INFO - Installing collected packages: blessings 03:36:27 INFO - Running setup.py install for blessings 03:36:27 INFO - Successfully installed blessings 03:36:27 INFO - Cleaning up... 03:36:27 INFO - Return code: 0 03:36:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:27 INFO - Reading from file tmpfile_stdout 03:36:27 INFO - Current package versions: 03:36:27 INFO - argparse == 1.2.1 03:36:27 INFO - blessings == 1.6 03:36:27 INFO - blobuploader == 1.2.4 03:36:27 INFO - docopt == 0.6.1 03:36:27 INFO - functools32 == 3.2.3-2 03:36:27 INFO - jsonschema == 2.5.1 03:36:27 INFO - manifestparser == 1.1 03:36:27 INFO - mozInstall == 1.13 03:36:27 INFO - mozcrash == 1.0 03:36:27 INFO - mozdebug == 0.1 03:36:27 INFO - mozdevice == 0.51 03:36:27 INFO - mozfile == 1.2 03:36:27 INFO - mozhttpd == 0.7 03:36:27 INFO - mozinfo == 0.10 03:36:27 INFO - mozleak == 0.1 03:36:27 INFO - mozlog == 3.5 03:36:27 INFO - moznetwork == 0.27 03:36:27 INFO - mozprocess == 0.25 03:36:27 INFO - mozprofile == 0.28 03:36:27 INFO - mozrunner == 6.13 03:36:27 INFO - mozscreenshot == 0.1 03:36:27 INFO - mozsystemmonitor == 0.3 03:36:27 INFO - moztest == 0.8 03:36:27 INFO - mozversion == 1.4 03:36:27 INFO - psutil == 3.1.1 03:36:27 INFO - requests == 1.2.3 03:36:27 INFO - wsgiref == 0.1.2 03:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:27 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')]} 03:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:27 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')]} 03:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:27 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:27 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 03:36:27 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 03:36:27 INFO - Using env: {'DISPLAY': ':0', 03:36:27 INFO - 'HOME': '/home/cltbld', 03:36:27 INFO - 'LANG': 'en_US.UTF-8', 03:36:27 INFO - 'LANGUAGE': 'en_US:en', 03:36:27 INFO - 'LOGNAME': 'cltbld', 03:36:27 INFO - 'MAIL': '/var/mail/cltbld', 03:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:27 INFO - 'MOZ_NO_REMOTE': '1', 03:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:27 INFO - 'NO_EM_RESTART': '1', 03:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:27 INFO - 'PWD': '/builds/slave/test', 03:36:27 INFO - 'SHELL': '/bin/bash', 03:36:27 INFO - 'SHLVL': '1', 03:36:27 INFO - 'TERM': 'linux', 03:36:27 INFO - 'TMOUT': '86400', 03:36:27 INFO - 'USER': 'cltbld', 03:36:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:27 INFO - '_': '/tools/buildbot/bin/python'} 03:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 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)) 03:36:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:36:27 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 03:36:27 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 03:36:27 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 03:36:27 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 03:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:36:29 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)) 03:36:29 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)) 03:36:29 INFO - Installing collected packages: simplejson 03:36:29 INFO - Running setup.py install for simplejson 03:36:29 INFO - building 'simplejson._speedups' extension 03:36:29 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 03:36:30 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 03:36:30 INFO - Successfully installed simplejson 03:36:30 INFO - Cleaning up... 03:36:30 INFO - Return code: 0 03:36:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:30 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')]} 03:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:30 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')]} 03:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:30 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 0x15c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', '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 03:36:30 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 03:36:30 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 03:36:30 INFO - Using env: {'DISPLAY': ':0', 03:36:30 INFO - 'HOME': '/home/cltbld', 03:36:30 INFO - 'LANG': 'en_US.UTF-8', 03:36:30 INFO - 'LANGUAGE': 'en_US:en', 03:36:30 INFO - 'LOGNAME': 'cltbld', 03:36:30 INFO - 'MAIL': '/var/mail/cltbld', 03:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:30 INFO - 'MOZ_NO_REMOTE': '1', 03:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:30 INFO - 'NO_EM_RESTART': '1', 03:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:30 INFO - 'PWD': '/builds/slave/test', 03:36:30 INFO - 'SHELL': '/bin/bash', 03:36:30 INFO - 'SHLVL': '1', 03:36:30 INFO - 'TERM': 'linux', 03:36:30 INFO - 'TMOUT': '86400', 03:36:30 INFO - 'USER': 'cltbld', 03:36:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:30 INFO - '_': '/tools/buildbot/bin/python'} 03:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:30 INFO - Cleaning up... 03:36:30 INFO - Return code: 0 03:36:30 INFO - Running post-action listener: _resource_record_post_action 03:36:30 INFO - Running post-action listener: _start_resource_monitoring 03:36:30 INFO - Starting resource monitoring. 03:36:30 INFO - [mozharness: 2017-09-09 10:36:30.440674Z] Finished create-virtualenv step (success) 03:36:30 INFO - [mozharness: 2017-09-09 10:36:30.441191Z] Running install step. 03:36:30 INFO - Running pre-action listener: _resource_record_pre_action 03:36:30 INFO - Running main action method: install 03:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:30 INFO - Reading from file tmpfile_stdout 03:36:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:30 INFO - Reading from file tmpfile_stdout 03:36:30 INFO - Output received: 03:36:30 INFO - Usage: mozinstall [options] installer 03:36:30 INFO - Options: 03:36:30 INFO - -h, --help show this help message and exit 03:36:30 INFO - -d DEST, --destination=DEST 03:36:30 INFO - Directory to install application into. [default: 03:36:30 INFO - "/builds/slave/test"] 03:36:30 INFO - --app=APP Application being installed. [default: firefox] 03:36:30 INFO - mkdir: /builds/slave/test/build/application 03:36:30 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'] 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:36:47 INFO - Reading from file tmpfile_stdout 03:36:47 INFO - Output received: 03:36:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:47 INFO - Running post-action listener: _resource_record_post_action 03:36:47 INFO - [mozharness: 2017-09-09 10:36:47.362559Z] Finished install step (success) 03:36:47 INFO - [mozharness: 2017-09-09 10:36:47.362814Z] Running setup-mitmproxy step. 03:36:47 INFO - Running pre-action listener: _resource_record_pre_action 03:36:47 INFO - Running main action method: setup_mitmproxy 03:36:47 INFO - Skipping: mitmproxy is not required 03:36:47 INFO - Running post-action listener: _resource_record_post_action 03:36:47 INFO - [mozharness: 2017-09-09 10:36:47.363996Z] Finished setup-mitmproxy step (success) 03:36:47 INFO - [mozharness: 2017-09-09 10:36:47.364216Z] Running run-tests step. 03:36:47 INFO - Running pre-action listener: _resource_record_pre_action 03:36:47 INFO - Running pre-action listener: _set_gcov_prefix 03:36:47 INFO - Running main action method: run_tests 03:36:47 WARNING - Try message not found. 03:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:47 INFO - Python 2.7.3 03:36:47 INFO - Return code: 0 03:36:47 INFO - grabbing minidump binary from tooltool 03:36: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')]} 03:36:47 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 0x1932090>, '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 0x1932d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:47 INFO - Return code: 0 03:36:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:47 INFO - ENV: RUST_BACKTRACE is now full 03:36:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:47 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/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 03:36:47 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/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 03:36:47 INFO - Using env: {'DISPLAY': ':0', 03:36:47 INFO - 'HOME': '/home/cltbld', 03:36:47 INFO - 'LANG': 'en_US.UTF-8', 03:36:47 INFO - 'LANGUAGE': 'en_US:en', 03:36:47 INFO - 'LOGNAME': 'cltbld', 03:36:47 INFO - 'MAIL': '/var/mail/cltbld', 03:36:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:47 INFO - 'MOZ_ACCELERATED': '1', 03:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:47 INFO - 'MOZ_NO_REMOTE': '1', 03:36:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:47 INFO - 'MOZ_WEBRENDER': '1', 03:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:47 INFO - 'NO_EM_RESTART': '1', 03:36:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:47 INFO - 'PWD': '/builds/slave/test', 03:36:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:47 INFO - 'RUST_BACKTRACE': 'full', 03:36:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:36:47 INFO - 'SHELL': '/bin/bash', 03:36:47 INFO - 'SHLVL': '1', 03:36:47 INFO - 'TERM': 'linux', 03:36:47 INFO - 'TMOUT': '86400', 03:36:47 INFO - 'USER': 'cltbld', 03:36:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:47 INFO - '_': '/tools/buildbot/bin/python'} 03:36:47 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/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 03:36:47 INFO - mozversion application_buildid: 20170909094348 03:36:47 INFO - mozversion application_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 03:36:47 INFO - mozversion application_display_name: Nightly 03:36:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:47 INFO - mozversion application_name: Firefox 03:36:47 INFO - mozversion application_remotingname: firefox 03:36:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:36:47 INFO - mozversion application_vendor: Mozilla 03:36:47 INFO - mozversion application_version: 57.0a1 03:36:47 INFO - mozversion platform_buildid: 20170909094348 03:36:47 INFO - mozversion platform_changeset: e0d88cd771d6791be4eaed4ada9315f4b26e2ad1 03:36:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:36:47 INFO - mozversion platform_version: 57.0a1 03:36:47 INFO - using testdate: 1504953407 03:36:47 INFO - actual date: 1504953407 03:36:47 INFO - starting webserver on 'localhost:59154' 03:36:47 INFO - SUITE-START | Running 2 tests 03:36:47 INFO - TEST-START | dromaeo_css 03:36:47 INFO - Initialising browser for dromaeo_css test... 03:36:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59154/getInfo.html -profile /tmp/tmpkf9Ch5/profile 03:36:47 INFO - TEST-INFO | started process 11196 (/builds/slave/test/build/application/firefox/firefox http://localhost:59154/getInfo.html) 03:36:55 INFO - TEST-INFO | 11196: exit 0 03:36:55 INFO - Browser initialized. 03:36:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:55 INFO - Using env: {'DISPLAY': ':0', 03:36:55 INFO - 'HOME': '/home/cltbld', 03:36:55 INFO - 'JSGC_DISABLE_POISONING': '1', 03:36:55 INFO - 'LANG': 'en_US.UTF-8', 03:36:55 INFO - 'LANGUAGE': 'en_US:en', 03:36:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:36:55 INFO - 'LOGNAME': 'cltbld', 03:36:55 INFO - 'MAIL': '/var/mail/cltbld', 03:36:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:55 INFO - 'MOZ_ACCELERATED': '1', 03:36:55 INFO - 'MOZ_CRASHREPORTER': '1', 03:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:36:55 INFO - 'MOZ_NO_REMOTE': '1', 03:36:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:55 INFO - 'MOZ_WEBRENDER': '1', 03:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:55 INFO - 'NO_EM_RESTART': '1', 03:36:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:55 INFO - 'PWD': '/builds/slave/test', 03:36:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:55 INFO - 'RUST_BACKTRACE': 'full', 03:36:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:36:55 INFO - 'SHELL': '/bin/bash', 03:36:55 INFO - 'SHLVL': '1', 03:36:55 INFO - 'TERM': 'linux', 03:36:55 INFO - 'TMOUT': '86400', 03:36:55 INFO - 'USER': 'cltbld', 03:36:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:55 INFO - '_': '/tools/buildbot/bin/python'} 03:36:55 INFO - TEST-INFO | started process 11405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkf9Ch5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:56 INFO - PID 11405 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:36:56 INFO - PID 11405 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:36:56 INFO - PID 11405 | 03:36:56 INFO - PID 11405 | (/builds/slave/test/build/application/firefox/firefox:11466): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:36:56 INFO - PID 11405 | 03:37:06 INFO - PID 11405 | RSS: Main: 212533248 03:37:06 INFO - PID 11405 | 03:40:04 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59154/tests/dromaeo/cssquery-ext.html) 03:40:06 INFO - PID 11405 | RSS: Main: 220241920 03:40:06 INFO - PID 11405 | 03:43:08 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-ext.html (next: http://localhost:59154/tests/dromaeo/cssquery-jquery.html) 03:43:08 INFO - PID 11405 | RSS: Main: 218451968 03:43:08 INFO - PID 11405 | 03:46:11 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59154/tests/dromaeo/cssquery-mootools.html) 03:46:11 INFO - PID 11405 | RSS: Main: 220233728 03:46:11 INFO - PID 11405 | 03:49:13 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59154/tests/dromaeo/cssquery-prototype.html) 03:49:14 INFO - PID 11405 | RSS: Main: 218849280 03:49:14 INFO - PID 11405 | 03:52:18 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59154/tests/dromaeo/cssquery-yui.html) 03:52:18 INFO - PID 11405 | RSS: Main: 220291072 03:52:18 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-yui.html (next: http://localhost:59154/tests/dromaeo/cssquery-dojo.html) 03:55:20 INFO - PID 11405 | RSS: Main: 226758656 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | __start_tp_report 03:55:20 INFO - PID 11405 | _x_x_mozilla_page_load 03:55:20 INFO - PID 11405 | _x_x_mozilla_page_load_details 03:55:20 INFO - PID 11405 | |i|pagename|runs| 03:55:20 INFO - PID 11405 | |0;dojo.html;3093.4741094014016;3094.7524198064157;3106.1458099022766;3115.4703700370933;3132.4361614909308;6097.817065488042;6247.187865577474;6295.968520157398;6310.68446577671;6339.524535659821;6134.785282515113;6180.381961803829;6227.532935029868;6233.906491402633;6245.500359971203;5723.198752174699;5740.052891272956;5748.511376533;5749.022666146744;5777.306723193223;5765.308163020443;5799.246098007275;5856.41435856413;5861.58968872177;5883.646981181143;5777.682227477487;5804.071348584227;5819.592628516006;5831.446012628793;5869.471747542721;5538.196961440609;5639.802606908738;5644.971775141098;5752.712364381785;5753.367129615739;5699.800506982236;5712.0860662293835;5730.08318669011;5776.075827867521;5779.075347944351;6065.423784740443;6079.635221886657;6224.906626400608;6226.034964580497;6231.439170474634;6413.134226879358;6492.448141907944;6551.05009773585;6626.503012274051;6668.999650052482;6653.567518111307;6673.132492775908;6717.865642687168;6725.730970761164;6732.2257940336995;6126.509879209652;6126.816195514097;6147.815565533041;6204.627722336629;6234.0337247726675;6771.8984215236815;6777.2545020047755;6822.863542729117;6854.417374523122;6870.896936545956;6407.775727849503;6495.610263384212;6499.512536559682;6499.8700025999215;6522.478201743944;6468.320826313264;6505;6513.739450422025;6533.607983521004;6578.111954886125;6532.836679082966;6622.304658010936;6663.4669226461765;6667.6666166691475;6688.197416310074;6629.635370054693;6657.167854018247;6712.295209003082;6715.3620406061345;6761.830954226085;5238.68567885928;5257.7896884124975;5268.341457317835;5275.920861187085;5333.5199832015305;4483.282674772021;4518.344839998182;4539.137563862855;4548.6133678637025;4634.165850147006;5631.465010823965;5685.943140568541;5703.800366987136;5711.514521265739;5720.713964301768;6710.563813352116;6742.932570674328;6752.054712340277;6755.560888542229;6766.086578311865;5666.121751128581;5674.943250567524;5727.656340619576;5737.311522617312;5738.971305143447;5614.747336369792;5616.606837521416;5683.914741278884;5716.5998380113;5770;6445.355464453611;6468.902966455507;6469.28837827848;6478.805635830932;6506.3818937200895;6704.329567043256;6710.530262881552;6725.730970761115;6739.6967136478;6772.898406523807;6362.268339141058;6420.518461115342;6471.417572418505;6530.640814755234;6535.869282614416;6376.234851817811;6580.473562115115;6603.9009414859775;6676.83307917306;6696.062551242927;6591.670416479253;6595.505337099833;6654.933450665431;6661.766838160641;6716.664166791738;6412.134361861089;6471.2234531856475;6496.382843630036;6513.804585862432;6516.152900122954;6469.935300646934;6482.384173503509;6561.245456772533;6565.540412171103;6569.146011018537;6238.126662267196;6410.294867564658;6482.611043337415;6520.706568204537;6520.902186467301;6418.711157997995;6470.255920569007;6555.4427873631275;6593.670316484253;6609.636469994004;6339.4928405726505;6353.36466353361;6367.108604795239;6415.133956915756;6434.227892652912 03:55:20 INFO - PID 11405 | |1;ext.html;866.3242670716841;879.555824308724;883.5140672630056;888.991110088899;890.3900827932866;38062.23875522491;38817.223655526876;41049.58950410495;41062.58937410629;41349.379759303636;38071;38571.22857542855;38690.41964370537;38752.80623596878;38820.80589597048;6964.442844572434;7154.570725756445;7156.785296441115;7159.64201789911;7168.032315637374;7017.82455438613;7152.177499587536;7167.3191046850725;7169.6773645186095;7171.497995140342;7072.398846098088;7117.608531530764;7126.073610430637;7132.964335178317;7144.214136444987;7089.858202835941;7641.3122818946285;7865.488743231672;7868.72459463916;7887;7769.7669069928;7821.648025838851;7842.29419352261;7845.411594130463;7845.803854903673;37807.810960945295;38181;38350;39432;40489;3538.575370955476;3600.8559657613664;3600.945985810215;3604.891853244381;3604.945925811115;32573.83713081443;32585.18537036593;32615.51076733851;32651;32721.34557308864;5178.482151784829;5197.8440646780655;5225.268462415265;5255.947440525584;5298.046351656701;186333;187718;189450;190140;190527;42357.57642423598;43098;49251.50748492541;50036.249456258185;50169;44550.55449445529;51312.486875131515;51604.74197628988;51805.48194518082;51879.740601296755;16309.184540772914;16314.510564683078;16495.587610309598;16526.83473165277;16545.420910268083;13482.988775841852;13534.93232533831;13572.524961626295;13610.59168224955;13620;13926.303684815719;14149.434022639185;14165;14242.572722818331;14271.286435678174;5816.88366232673;5842.561807864342;5941.524678025748;5951.196588460589;6045.3652366501765;1011.8026984737905;1035.4563853976572;1041.6406339812752;1042.5048102151568;1043.8225501664735;23184.884075579852;23403.297901062655;23429.41426464318;23514.529709405717;23641.054357825495;1136.5681041204289;1141.4463984967285;1142.2232881640564;1142.5601143559622;1146.6789298996293;12340.50637974471;12425;12497.18768280059;12633.178843375152;12701;224315;225846;226032;226550;226588;52323;52382.21426678603;52410.737946310786;52579.21131183035;53090.20364694532;1431.51328548292;1478.3273610507408;1491.671832196915;1502.9248537573078;1509.5697726147996;22964.540709186058;22970.19604313841;23024.884875576186;23067.307980760605;23073.423164421023;36818.26363472769;37180.25639487141;37263;37265.0683732898;37290.62709372872;189234;191245;191512;191871;192136;33825.661743383236;34171.46228419677;35361;35409.64590354166;35522.467162993096;44710.3293450605;45656;46203;46406;46451.53548464472;32894.842063173965;32974.67025329716;33063.33873322568;33169.50245746267;33311.50032749462;32699;32788;32815.671843282216;32940.34119317648;33000.834995824865;36221;37116.443253350684;37864.242715146094;38074.8096259528;38253.80873095617;32032;32603.673963260062;32739.836300818344;33050.33899322048;33085.83457082699;23528.41178970471;23974.76025239795;24759.752402476464;24817;24830.751692482845 03:55:20 INFO - PID 11405 | |2;jquery.html;565.2736233939386;569.1207085053592;573.5411670663469;574.8591595059206;580.8112363481869;22519.774802251974;23037.078516859325;23192.8840355798;23286.76713232867;23312.184073557386;23162.536749265004;24217.152399666014;24264.02943882247;24507;24547;6233.906491402633;6481.675916204194;6514.837129071764;6524.15186025816;6566.310537393577;6414.454771344442;6527.41253287204;6528.281888992231;6529.640869752162;6530.053142294364;6190.226221722285;6404.487640988733;6459.5478316517865;6479.2224933007865;6493.837654058639;6447.677616119176;6473.546851720382;6504.414602685781;6518.771842985473;6519.902201466982;5840.678762668052;6010.8497287567725;6088;6092.603980741238;6105.297890742577;28783;29042;29396;29427;29468.11595652134;2032.9186832526682;2080.4278823323557;2093.194120263694;2094.98952505238;2105.1684584589157;18736.718949215774;19357;19643.410697679094;19661.213551458066;19845.801541984685;2366.7396586375485;2396.880155992211;2435.0259896041725;2440.389902524369;2440.4996975619956;117148.41425792816;126226;126238;131728;135880;14256.215908125152;14263.85736142646;14379.609162575092;14398.20809855447;14466.855331446552;22792.544149116926;22845.771542284696;22874.199403021146;22916.656250156262;22925.88537057304;9752.707418777449;9980.2514811388;10097.242706796873;10144.898551014543;10253.84619230712;9376.29677774156;9461.76345591352;9558;9585.616575337048;9607.13535781783;8618.224359807522;8741.30069594431;8904.510251936206;8912.598933048028;8970.058143894928;2712.742289482496;2723.101376545735;2737.986310068437;2761.7514423701964;2764.875580598878;954.1174413667469;972.8443449048118;974.7465658928729;974.7514383832078;977.379364103785;18808.905955470407;19269.518262043563;19288.8071119287;19392.515187120152;19603.8039619602;1011.8161402600155;1013.7668336282549;1014.9086582207489;1021.6271061062658;1034.963776267827;10524.789504209873;10732.356058636507;10857.457127143769;10864.511097000654;10941.070009049161;427136;431591;444167;444971;445661;108099.45950270198;108190;108235;109955;110196.44901775439;1034.6016783538391;1066.9839952400564;1113.6046703420332;1138.4023387721347;1172.3083380805365;18793.90603046976;19729.309474168334;20115.899420502803;20306.69539956872;20456.59086818285;53314;55935;56521.43478565162;56579.43420565906;56693;69973.30026699668;70139.64930175521;70355.64822175856;70800.64599676969;71324.64337678278;14044.78932815988;14216.431342746175;14241.857581424467;14385.568432947028;14417.711645766816;22415.43961400978;22567.435814104778;22569;22586.887065564566;23031.424214394774;17887.28450861951;18043.09784510743;18188.727169092737;18195.272189112817;18422.63154736871;15141.394344226108;15274.694506109594;15904.681906361577;15953.840461595235;16622.25199865985;18438.35465758692;18546.536336591693;18575;18716.438506844817;18856.622867542847;13962.301884905917;14114.717705646035;14115.153090814583;14185.148891066568;14194.290285485478;17521.561960950567;17829;17880;18106.275748969892;18175.45508631728 03:55:20 INFO - PID 11405 | |3;mootools.html;1309.5547513845293;1370.49291762048;1383.2323060701306;1383.6333371656506;1397.1756663568497;14712.558623241306;15932.681346373065;15976.680466390666;15985.600359991005;15989.360425582978;15715.135667538309;15817.60455988598;15853.682926341495;15900.284487198074;16012.43956461524;2759.089500464852;2816.070696670094;2816.3944751878344;2828.75955543778;2831.207261966653;2685.1273336165727;2742.0676969830256;2761.585762135686;2763.2539214412195;2766.0595397564825;2664.3472349274457;2713.6743590769133;2729.113038262563;2737.466194092153;2885.321949341903;2782.0541016054535;2850.2874281429645;2850.5296626056675;2852.115844088339;2852.614896988901;2717.5244332241778;2724.1691284158323;2754.5730411786203;2760.8481533515646;2766.0871912268904;14910.552683419515;14968.850311496855;15271.465498707492;15435.614109647237;15499.845001549953;8070.192980701941;8382.497050176948;8419.07390187079;8421.452605580618;8426.536540490271;5478.58910581704;5670;5706.087026075849;5731.168980497846;5749.770009199627;1916.3101283537915;1936.5836345185853;1951.5706544560173;1970.5861769028522;2009.577988622391;26277.08030218933;26570;26596.86701566499;26612.86693566539;26621.60067598968;6722.361375669304;6897.137772801316;6912.447004239649;6922.896156557656;7098.858022839618;17128.14359282031;17138.31446742116;17144.828551714574;17163.141842907804;17183.65632687339;7886.526808391515;8050.396220283502;8052.194780522018;8055.959720201478;8064.233897779702;7253.419726421874;7268.45486588508;7371.115466144097;7439.702411903571;7518.812029699192;5246.816361427332;5300.045991721528;5423.5932305076485;5460.863478413072;5472.50747432733;1470.6176394137387;1487.1746180869504;1510;1511.2292730707418;1538.4384699584796;885.7874110213502;900.7838118851429;910.3763921713647;912.6030176873081;921.3366376209119;7680.577568233801;7685.154632990367;7702.8844567331535;7815.4529182957785;8250.257476826995;667.1926968368329;701.8140192848899;705.9047028651066;706.6855249414065;707.1443553300461;4789.521047895252;5032.572231360376;5100.923486147711;5154.098032844237;5221;21055.157793688388;21708.674369884466;21716.45708857291;22041.338759837232;22068.33794986121;20515.589688206153;21321;21537.892310538347;21556.245531406326;21805.67291490629;10942.890571094187;10947.945260273647;11152.386618735885;11306.773864522664;11326.603568875049;8386.077531471412;8510.106438823834;8524.232819046316;8529.658813647384;8597.355198360274;18102.637947240717;18118;18279.26882924668;18394;18606.627867442847;18554.81445185531;19105.90447047756;19141.80858191456;19155.521111972314;19737.210511579375;11006.779864402506;11089.5564177432;11264.211505194558;11271.661850144508;11273.267237629529;13253.13854599448;13318.933405332911;13503.12229705066;13580.185188888698;13593.252371119683;10589.152867770714;10707.464626768786;10747.516361763583;10817.513211905325;10918.454077295944;10869.836952445878;11094.889051109709;11231.21381503287;11234.269772464764;11416.372099534605;9099.863502047343;9293.581788819383;9329.11373419524;9329.813403732023;9342.159205671522;7429.479936404616;7540.547567145989;7635.923640763744;7656.042994625672;7668.923310767044;7250.927490725026;7429.851402972018;7500.512466689648;7523.699052037857;7530.134034585873 03:55:20 INFO - PID 11405 | |4;prototype.html;499.9502041629319;504.67317464165717;511.5958392869633;521.1011006014622;528.5480913818685;6208.1308616793685;6304.807303143416;6320.30476647569;6385.968070159648;6416.262129855062;6194.535409844257;6198.566100372976;6200.968995155029;6221.284552276489;6232.189815324013;5121.487851214886;5175.8188463403785;5178.766955487003;5210.426853046162;5219.947800521984;5147.71687557186;5168.2764412982215;5176.66351687141;5215.478452154792;5231.398389185254;4827.927581086286;4887.853364399056;4890.193118135503;4974.77613507393;5151.5878729701535;4913.975430122827;4969.577585905203;4974.204127339626;4980.900381992376;5021.14640511114;4425.137098265839;4445.8221671133115;4452.955470445287;4471.910561788779;4485.416895803524;5886.676232807236;6046.576739628228;6078.848028799272;6118.4799292060225;6152.415520525543;5550.5282051025715;5571.665700057969;5607.495325420732;5621.8594535136535;5649.180868774046;6512.706928188243;6540.084388185658;6571.408573228432;6586.835329116762;6639.634820084893;4572.0568758277595;4735.266033764772;4783.880402989953;4825.469198388175;4826.913944362525;6688.531802773857;6701.855406269947;6730.865382692367;6750.223724271723;6756.493263005245;4964.709175614366;4976.029674213493;4984.90030199394;4995.425526064549;5025.547700706881;5004.899902001939;5006.173981293119;5020.949790502122;5025.974870125699;5074.112030394666;5542.7782888684005;5614.63504872182;5644.407337229532;5681.9431805681415;5687.914681279784;6508.420368797143;6545.312742162099;6591.769288074895;6601.3068627794355;6678.666066696645;1725.9730460376306;1736.7047601907707;1759.6304775997185;1766.9823301767076;1770.8140645232065;1146.1174895330716;1206.8414322250562;1215.3072748533252;1222.10175520992;1223.431104536377;5563.3031925263185;5594.300712410949;5622.690752008679;5702.460335709336;5714.79998200061;6643.634600097041;6646.069550262967;6660.833479162963;6757.425618822455;6762.985552167214;5606.673230609333;5697.971510142505;5715;5728.713564321767;5739.16782066598;3486.8430920608635;3550.715942724576;3552.5381700378784;3561.8397172127316;3580.695640870503;6382.32985536512;6450.258220304631;6469.191351081115;6495.642739649365;6506.25178104524;6849.383555480031;6853.280405557444;6902.654867256617;6909.2745261746795;6968;6091.9695401523595;6423.008867251167;6525.3474652535315;6528.640924749185;6580.309067547934;6547.836304092436;6569.178852643419;6601.3728695773825;6664.866702666017;6711.798646040431;6568.770093046721;6620.867582648224;6637.900431493628;6649.038533632687;6707.862305990159;6259.436650701276;6348.968255158879;6353.680906469198;6392.872142557216;6429.324920883427;4929.7535123244415;4958.983408401341;4980.975095124501;4992.126377883928;5039.067772462106;6528.857449946336;6658.733650654113;6670.66646667655;6805.570830125729;6841.555298905555;6268.122462855295;6395.993882875041;6462.289148193601;6476.481881449378;6516.250631177286;6474.320196379501;6534.771283005072;6543.051257567721;6559.4752419805345;6561.409473147249;6346.2067241594805;6391.2330520337855;6441.3880681335195;6489.8702025960165;6516.771912983023;6550.803475895731;6578.914504083799;6579.111819904251;6606.4384527315715;6665.833354166185;6389.648569328731;6418.614883107029;6433.324500927522;6458.838529036811;6471.773487928088 03:55:20 INFO - PID 11405 | |5;yui.html;887.7114937645265;890.7684002159436;907.6596276396356;919.747069555872;933.8599210118483;17400;18364.44906652801;18365.173567189475;18416.631667366644;18447.44657660269;14863.92568037161;14888.330025148867;14914.403423863032;14976.026558273705;17299.481015569523;943.094629156011;962.7737481691797;963.335298643937;964.2237998411312;966.3960024984385;975.4537459022935;977.1254727019314;978.7553111722069;979.4319294809029;979.6962941488126;975.5024937281967;1031.2471895516278;1037.8183817831887;1039.6257347354947;1039.7868436970402;1010.711947095078;1016.6187679620142;1022.2384323678907;1022.9999999999962;1023.8976102389776;721.5995122706895;741.907261592301;746.8319628083638;752;752.0336367767447;18611.906940465346;18727.719084213746;18738.718919216088;18812.341568045053;18882.150303236387;21370;21372.893135534378;22261.777382226133;22370.105195792148;22506.43733906649;17277;17698.292068317252;17840.732389014174;17840.821591784046;17875.73186402205;3750.1562148516637;3801.657850793414;3802.315583195024;3802.524684414448;3803.315403227418;136985;138790;140128;140876.99999999898;141012;16485.423010194587;16727.414540491023;16729.91635041817;16921.323147073977;16922.74615880763;31067.378652426825;32171.195720106716;32191.195220119684;32278.83860580682;32383;7944.761657150295;7948.403869709795;8005.759827205193;8020.759377218693;8035.357171426389;3747.2505498900327;3761.6614504694708;3771.30230907283;3779.4897688812207;3828.1769419574366;5322.201669749568;5379.462053794589;5399.406065332811;5431.131019036935;5444.3194600674915;984.7390441532999;1011.600417834951;1026.199564339816;1033.6743925663393;1037.2998226197287;687.3161204601454;698.179638924262;707.7699747582056;717.5730440387961;723.6580516898608;11340.376279304717;11673.357965311989;11675.591354302729;12494.06294527914;12572;674.3189378727423;680.6562685843618;683.7265093962454;690.8203866994618;699.1784653032666;5573.7770489179975;5614.129809879475;5621.690807005654;5646.71766411686;5753.252077229933;123879.3806030964;124036.37981810034;127041;129585.35207323903;129765.35117324353;110141;110327;110577.44711276393;111155.44422277837;115837;89767;90195.54902225579;91163.54418227867;91985;93444.53277733568;10056.64801731936;10148.238882083726;10205.74485637865;10279.486025698536;10305.484725763832;43538.34692479552;44131.77934110309;44257.778711106235;45598.772006139756;46625.06749865052;56935.43064569301;57599.71200143972;58050.709746451;59889.401105988385;60054.39945600488;15241.466548670744;15936.601584960004;15944.36222551085;15992.92003539975;16096.67806643884;16333.918330408273;17085.48743537696;17255.65488690194;17362.73955890688;17508.124593770004;14623.707525849637;14940.701185976002;15169.620759481102;15254.694906102039;15396.84603153954;14296.785548216578;14307.57077287683;14464.20446875432;14545.200013998909;14603.123812571279;14272.643183920485;14387.640308992359;14543.85456145425;14640.487582934546;14816.036957597722;11755.471003804678;12041.578544750892;12050.457729402022;12057.216280941711;12261.938690306491;11255.943720281673;11347.48936297852;11487.25332853362;11551.711207219887;12025.037996960396 03:55:20 INFO - PID 11405 | __end_tp_report 03:55:20 INFO - PID 11405 | __start_cc_report 03:55:20 INFO - PID 11405 | _x_x_mozilla_cycle_collect,366 03:55:20 INFO - PID 11405 | __end_cc_report 03:55:20 INFO - PID 11405 | __startTimestamp1504954520952__endTimestamp 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | ------- Summary: start ------- 03:55:20 INFO - PID 11405 | Number of tests: 6 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#0] dojo.html Cycles:165 Average:6121.77 Median:6410.29 stddev:733.29 (11.4%) stddev-sans-first:695.99 03:55:20 INFO - PID 11405 | Values: 3093.5 3094.8 3106.1 3115.5 3132.4 6097.8 6247.2 6296.0 6310.7 6339.5 6134.8 6180.4 6227.5 6233.9 6245.5 5723.2 5740.1 5748.5 5749.0 5777.3 5765.3 5799.2 5856.4 5861.6 5883.6 5777.7 5804.1 5819.6 5831.4 5869.5 5538.2 5639.8 5645.0 5752.7 5753.4 5699.8 5712.1 5730.1 5776.1 5779.1 6065.4 6079.6 6224.9 6226.0 6231.4 6413.1 6492.4 6551.1 6626.5 6669.0 6653.6 6673.1 6717.9 6725.7 6732.2 6126.5 6126.8 6147.8 6204.6 6234.0 6771.9 6777.3 6822.9 6854.4 6870.9 6407.8 6495.6 6499.5 6499.9 6522.5 6468.3 6505.0 6513.7 6533.6 6578.1 6532.8 6622.3 6663.5 6667.7 6688.2 6629.6 6657.2 6712.3 6715.4 6761.8 5238.7 5257.8 5268.3 5275.9 5333.5 4483.3 4518.3 4539.1 4548.6 4634.2 5631.5 5685.9 5703.8 5711.5 5720.7 6710.6 6742.9 6752.1 6755.6 6766.1 5666.1 5674.9 5727.7 5737.3 5739.0 5614.7 5616.6 5683.9 5716.6 5770.0 6445.4 6468.9 6469.3 6478.8 6506.4 6704.3 6710.5 6725.7 6739.7 6772.9 6362.3 6420.5 6471.4 6530.6 6535.9 6376.2 6580.5 6603.9 6676.8 6696.1 6591.7 6595.5 6654.9 6661.8 6716.7 6412.1 6471.2 6496.4 6513.8 6516.2 6469.9 6482.4 6561.2 6565.5 6569.1 6238.1 6410.3 6482.6 6520.7 6520.9 6418.7 6470.3 6555.4 6593.7 6609.6 6339.5 6353.4 6367.1 6415.1 6434.2 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#1] ext.html Cycles:180 Average:37319.71 Median:19561.66 stddev:52446.09 (268.1%) stddev-sans-first:52521.79 03:55:20 INFO - PID 11405 | Values: 866.3 879.6 883.5 889.0 890.4 38062.2 38817.2 41049.6 41062.6 41349.4 38071.0 38571.2 38690.4 38752.8 38820.8 6964.4 7154.6 7156.8 7159.6 7168.0 7017.8 7152.2 7167.3 7169.7 7171.5 7072.4 7117.6 7126.1 7133.0 7144.2 7089.9 7641.3 7865.5 7868.7 7887.0 7769.8 7821.6 7842.3 7845.4 7845.8 37807.8 38181.0 38350.0 39432.0 40489.0 3538.6 3600.9 3600.9 3604.9 3604.9 32573.8 32585.2 32615.5 32651.0 32721.3 5178.5 5197.8 5225.3 5255.9 5298.0 186333.0 187718.0 189450.0 190140.0 190527.0 42357.6 43098.0 49251.5 50036.2 50169.0 44550.6 51312.5 51604.7 51805.5 51879.7 16309.2 16314.5 16495.6 16526.8 16545.4 13483.0 13534.9 13572.5 13610.6 13620.0 13926.3 14149.4 14165.0 14242.6 14271.3 5816.9 5842.6 5941.5 5951.2 6045.4 1011.8 1035.5 1041.6 1042.5 1043.8 23184.9 23403.3 23429.4 23514.5 23641.1 1136.6 1141.4 1142.2 1142.6 1146.7 12340.5 12425.0 12497.2 12633.2 12701.0 224315.0 225846.0 226032.0 226550.0 226588.0 52323.0 52382.2 52410.7 52579.2 53090.2 1431.5 1478.3 1491.7 1502.9 1509.6 22964.5 22970.2 23024.9 23067.3 23073.4 36818.3 37180.3 37263.0 37265.1 37290.6 189234.0 191245.0 191512.0 191871.0 192136.0 33825.7 34171.5 35361.0 35409.6 35522.5 44710.3 45656.0 46203.0 46406.0 46451.5 32894.8 32974.7 33063.3 33169.5 33311.5 32699.0 32788.0 32815.7 32940.3 33000.8 36221.0 37116.4 37864.2 38074.8 38253.8 32032.0 32603.7 32739.8 33050.3 33085.8 23528.4 23974.8 24759.8 24817.0 24830.8 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#2] jquery.html Cycles:180 Average:32697.61 Median:22895.43 stddev:74159.80 (323.9%) stddev-sans-first:74328.59 03:55:20 INFO - PID 11405 | Values: 565.3 569.1 573.5 574.9 580.8 22519.8 23037.1 23192.9 23286.8 23312.2 23162.5 24217.2 24264.0 24507.0 24547.0 6233.9 6481.7 6514.8 6524.2 6566.3 6414.5 6527.4 6528.3 6529.6 6530.1 6190.2 6404.5 6459.5 6479.2 6493.8 6447.7 6473.5 6504.4 6518.8 6519.9 5840.7 6010.8 6088.0 6092.6 6105.3 28783.0 29042.0 29396.0 29427.0 29468.1 2032.9 2080.4 2093.2 2095.0 2105.2 18736.7 19357.0 19643.4 19661.2 19845.8 2366.7 2396.9 2435.0 2440.4 2440.5 117148.4 126226.0 126238.0 131728.0 135880.0 14256.2 14263.9 14379.6 14398.2 14466.9 22792.5 22845.8 22874.2 22916.7 22925.9 9752.7 9980.3 10097.2 10144.9 10253.8 9376.3 9461.8 9558.0 9585.6 9607.1 8618.2 8741.3 8904.5 8912.6 8970.1 2712.7 2723.1 2738.0 2761.8 2764.9 954.1 972.8 974.7 974.8 977.4 18808.9 19269.5 19288.8 19392.5 19603.8 1011.8 1013.8 1014.9 1021.6 1035.0 10524.8 10732.4 10857.5 10864.5 10941.1 427136.0 431591.0 444167.0 444971.0 445661.0 108099.5 108190.0 108235.0 109955.0 110196.4 1034.6 1067.0 1113.6 1138.4 1172.3 18793.9 19729.3 20115.9 20306.7 20456.6 53314.0 55935.0 56521.4 56579.4 56693.0 69973.3 70139.6 70355.6 70800.6 71324.6 14044.8 14216.4 14241.9 14385.6 14417.7 22415.4 22567.4 22569.0 22586.9 23031.4 17887.3 18043.1 18188.7 18195.3 18422.6 15141.4 15274.7 15904.7 15953.8 16622.3 18438.4 18546.5 18575.0 18716.4 18856.6 13962.3 14114.7 14115.2 14185.1 14194.3 17521.6 17829.0 17880.0 18106.3 18175.5 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#3] mootools.html Cycles:180 Average:9344.38 Median:2733.29 stddev:6661.12 (243.7%) stddev-sans-first:6652.45 03:55:20 INFO - PID 11405 | Values: 1309.6 1370.5 1383.2 1383.6 1397.2 14712.6 15932.7 15976.7 15985.6 15989.4 15715.1 15817.6 15853.7 15900.3 16012.4 2759.1 2816.1 2816.4 2828.8 2831.2 2685.1 2742.1 2761.6 2763.3 2766.1 2664.3 2713.7 2729.1 2737.5 2885.3 2782.1 2850.3 2850.5 2852.1 2852.6 2717.5 2724.2 2754.6 2760.8 2766.1 14910.6 14968.9 15271.5 15435.6 15499.8 8070.2 8382.5 8419.1 8421.5 8426.5 5478.6 5670.0 5706.1 5731.2 5749.8 1916.3 1936.6 1951.6 1970.6 2009.6 26277.1 26570.0 26596.9 26612.9 26621.6 6722.4 6897.1 6912.4 6922.9 7098.9 17128.1 17138.3 17144.8 17163.1 17183.7 7886.5 8050.4 8052.2 8056.0 8064.2 7253.4 7268.5 7371.1 7439.7 7518.8 5246.8 5300.0 5423.6 5460.9 5472.5 1470.6 1487.2 1510.0 1511.2 1538.4 885.8 900.8 910.4 912.6 921.3 7680.6 7685.2 7702.9 7815.5 8250.3 667.2 701.8 705.9 706.7 707.1 4789.5 5032.6 5100.9 5154.1 5221.0 21055.2 21708.7 21716.5 22041.3 22068.3 20515.6 21321.0 21537.9 21556.2 21805.7 10942.9 10947.9 11152.4 11306.8 11326.6 8386.1 8510.1 8524.2 8529.7 8597.4 18102.6 18118.0 18279.3 18394.0 18606.6 18554.8 19105.9 19141.8 19155.5 19737.2 11006.8 11089.6 11264.2 11271.7 11273.3 13253.1 13318.9 13503.1 13580.2 13593.3 10589.2 10707.5 10747.5 10817.5 10918.5 10869.8 11094.9 11231.2 11234.3 11416.4 9099.9 9293.6 9329.1 9329.8 9342.2 7429.5 7540.5 7635.9 7656.0 7668.9 7250.9 7429.9 7500.5 7523.7 7530.1 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#4] prototype.html Cycles:180 Average:5493.61 Median:6173.48 stddev:1538.11 (24.9%) stddev-sans-first:1496.06 03:55:20 INFO - PID 11405 | Values: 500.0 504.7 511.6 521.1 528.5 6208.1 6304.8 6320.3 6386.0 6416.3 6194.5 6198.6 6201.0 6221.3 6232.2 5121.5 5175.8 5178.8 5210.4 5219.9 5147.7 5168.3 5176.7 5215.5 5231.4 4827.9 4887.9 4890.2 4974.8 5151.6 4914.0 4969.6 4974.2 4980.9 5021.1 4425.1 4445.8 4453.0 4471.9 4485.4 5886.7 6046.6 6078.8 6118.5 6152.4 5550.5 5571.7 5607.5 5621.9 5649.2 6512.7 6540.1 6571.4 6586.8 6639.6 4572.1 4735.3 4783.9 4825.5 4826.9 6688.5 6701.9 6730.9 6750.2 6756.5 4964.7 4976.0 4984.9 4995.4 5025.5 5004.9 5006.2 5020.9 5026.0 5074.1 5542.8 5614.6 5644.4 5681.9 5687.9 6508.4 6545.3 6591.8 6601.3 6678.7 1726.0 1736.7 1759.6 1767.0 1770.8 1146.1 1206.8 1215.3 1222.1 1223.4 5563.3 5594.3 5622.7 5702.5 5714.8 6643.6 6646.1 6660.8 6757.4 6763.0 5606.7 5698.0 5715.0 5728.7 5739.2 3486.8 3550.7 3552.5 3561.8 3580.7 6382.3 6450.3 6469.2 6495.6 6506.3 6849.4 6853.3 6902.7 6909.3 6968.0 6092.0 6423.0 6525.3 6528.6 6580.3 6547.8 6569.2 6601.4 6664.9 6711.8 6568.8 6620.9 6637.9 6649.0 6707.9 6259.4 6349.0 6353.7 6392.9 6429.3 4929.8 4959.0 4981.0 4992.1 5039.1 6528.9 6658.7 6670.7 6805.6 6841.6 6268.1 6396.0 6462.3 6476.5 6516.3 6474.3 6534.8 6543.1 6559.5 6561.4 6346.2 6391.2 6441.4 6489.9 6516.8 6550.8 6578.9 6579.1 6606.4 6665.8 6389.6 6418.6 6433.3 6458.8 6471.8 03:55:20 INFO - PID 11405 | 03:55:20 INFO - PID 11405 | [#5] yui.html Cycles:180 Average:24189.96 Median:18390.90 stddev:35709.24 (194.2%) stddev-sans-first:35766.55 03:55:20 INFO - PID 11405 | Values: 887.7 890.8 907.7 919.7 933.9 17400.0 18364.4 18365.2 18416.6 18447.4 14863.9 14888.3 14914.4 14976.0 17299.5 943.1 962.8 963.3 964.2 966.4 975.5 977.1 978.8 979.4 979.7 975.5 1031.2 1037.8 1039.6 1039.8 1010.7 1016.6 1022.2 1023.0 1023.9 721.6 741.9 746.8 752.0 752.0 18611.9 18727.7 18738.7 18812.3 18882.2 21370.0 21372.9 22261.8 22370.1 22506.4 17277.0 17698.3 17840.7 17840.8 17875.7 3750.2 3801.7 3802.3 3802.5 3803.3 136985.0 138790.0 140128.0 140877.0 141012.0 16485.4 16727.4 16729.9 16921.3 16922.7 31067.4 32171.2 32191.2 32278.8 32383.0 7944.8 7948.4 8005.8 8020.8 8035.4 3747.3 3761.7 3771.3 3779.5 3828.2 5322.2 5379.5 5399.4 5431.1 5444.3 984.7 1011.6 1026.2 1033.7 1037.3 687.3 698.2 707.8 717.6 723.7 11340.4 11673.4 11675.6 12494.1 12572.0 674.3 680.7 683.7 690.8 699.2 5573.8 5614.1 5621.7 5646.7 5753.3 123879.4 124036.4 127041.0 129585.4 129765.4 110141.0 110327.0 110577.4 111155.4 115837.0 89767.0 90195.5 91163.5 91985.0 93444.5 10056.6 10148.2 10205.7 10279.5 10305.5 43538.3 44131.8 44257.8 45598.8 46625.1 56935.4 57599.7 58050.7 59889.4 60054.4 15241.5 15936.6 15944.4 15992.9 16096.7 16333.9 17085.5 17255.7 17362.7 17508.1 14623.7 14940.7 15169.6 15254.7 15396.8 14296.8 14307.6 14464.2 14545.2 14603.1 14272.6 14387.6 14543.9 14640.5 14816.0 11755.5 12041.6 12050.5 12057.2 12261.9 11255.9 11347.5 11487.3 11551.7 12025.0 03:55:20 INFO - PID 11405 | -------- Summary: end -------- 03:55:20 INFO - PID 11405 | 03:55:21 INFO - TEST-INFO | 11405: exit 0 03:55:21 INFO - TEST-OK | dromaeo_css | took 1114090ms 03:55:21 INFO - TEST-START | kraken 03:55:21 INFO - Initialising browser for kraken test... 03:55:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59154/getInfo.html -profile /tmp/tmp2rwU8y/profile 03:55:21 INFO - TEST-INFO | started process 11798 (/builds/slave/test/build/application/firefox/firefox http://localhost:59154/getInfo.html) 03:55:28 INFO - TEST-INFO | 11798: exit 0 03:55:28 INFO - Browser initialized. 03:55:28 INFO - Running cycle 1/1 for kraken test... 03:55:28 INFO - Using env: {'DISPLAY': ':0', 03:55:28 INFO - 'HOME': '/home/cltbld', 03:55:28 INFO - 'JSGC_DISABLE_POISONING': '1', 03:55:28 INFO - 'LANG': 'en_US.UTF-8', 03:55:28 INFO - 'LANGUAGE': 'en_US:en', 03:55:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:55:28 INFO - 'LOGNAME': 'cltbld', 03:55:28 INFO - 'MAIL': '/var/mail/cltbld', 03:55:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:28 INFO - 'MOZ_ACCELERATED': '1', 03:55:28 INFO - 'MOZ_CRASHREPORTER': '1', 03:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:55:28 INFO - 'MOZ_NO_REMOTE': '1', 03:55:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:28 INFO - 'MOZ_WEBRENDER': '1', 03:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:28 INFO - 'NO_EM_RESTART': '1', 03:55:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:28 INFO - 'PWD': '/builds/slave/test', 03:55:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:28 INFO - 'RUST_BACKTRACE': 'full', 03:55:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:55:28 INFO - 'SHELL': '/bin/bash', 03:55:28 INFO - 'SHLVL': '1', 03:55:28 INFO - 'TERM': 'linux', 03:55:28 INFO - 'TMOUT': '86400', 03:55:28 INFO - 'USER': 'cltbld', 03:55:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345', 03:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:28 INFO - '_': '/tools/buildbot/bin/python'} 03:55:28 INFO - TEST-INFO | started process 12001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2rwU8y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:29 INFO - PID 12001 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:29 INFO - PID 12001 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:29 INFO - PID 12001 | 03:55:29 INFO - PID 12001 | (/builds/slave/test/build/application/firefox/firefox:12062): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:55:29 INFO - PID 12001 | 03:55:40 INFO - PID 12001 | RSS: Main: 210264064 03:55:40 INFO - PID 12001 | 03:55:42 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:43 INFO - PID 12001 | RSS: Main: 215494656 03:55:43 INFO - PID 12001 | 03:55:46 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-dft) 03:55:47 INFO - PID 12001 | RSS: Main: 215359488 03:55:47 INFO - PID 12001 | 03:55:50 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-fft) 03:55:50 INFO - PID 12001 | RSS: Main: 212373504 03:55:50 INFO - PID 12001 | 03:55:53 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-oscillator) 03:55:53 INFO - PID 12001 | RSS: Main: 214024192 03:55:53 INFO - PID 12001 | 03:55:55 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:56 INFO - PID 12001 | RSS: Main: 213979136 03:55:56 INFO - PID 12001 | 03:55:59 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:00 INFO - PID 12001 | RSS: Main: 216600576 03:56:00 INFO - PID 12001 | 03:56:03 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:04 INFO - PID 12001 | RSS: Main: 214822912 03:56:04 INFO - PID 12001 | 03:56:07 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59154/tests/kraken/driver.html?testName=json-parse-financial) 03:56:08 INFO - PID 12001 | RSS: Main: 217223168 03:56:08 INFO - PID 12001 | 03:56:09 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:10 INFO - PID 12001 | RSS: Main: 216539136 03:56:10 INFO - PID 12001 | 03:56:12 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:12 INFO - PID 12001 | RSS: Main: 213897216 03:56:12 INFO - PID 12001 | 03:56:14 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:15 INFO - PID 12001 | RSS: Main: 212889600 03:56:15 INFO - PID 12001 | 03:56:18 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:19 INFO - PID 12001 | RSS: Main: 213344256 03:56:19 INFO - PID 12001 | 03:56:22 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:22 INFO - PID 12001 | RSS: Main: 213405696 03:56:22 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59154/tests/kraken/driver.html?testName=ai-astar) 03:56:24 INFO - PID 12001 | RSS: Main: 217227264 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | __start_tp_report 03:56:24 INFO - PID 12001 | _x_x_mozilla_page_load 03:56:24 INFO - PID 12001 | _x_x_mozilla_page_load_details 03:56:24 INFO - PID 12001 | |i|pagename|runs| 03:56:24 INFO - PID 12001 | |0;ai-astar;116;111;115;109;111;108;112;114;121;117 03:56:24 INFO - PID 12001 | |1;audio-beat-detection;118;119;128;122;116;143;126;118;117;126 03:56:24 INFO - PID 12001 | |2;audio-dft;162;172;163;163;170;169;171;163;164;162 03:56:24 INFO - PID 12001 | |3;audio-fft;76;83;79;76;74;78;75;81;78;81 03:56:24 INFO - PID 12001 | |4;audio-oscillator;85;79;88;79;80;80;81;81;85;79 03:56:24 INFO - PID 12001 | |5;imaging-gaussian-blur;116;115;115;115;114;115;115;117;112;116 03:56:24 INFO - PID 12001 | |6;imaging-darkroom;150;148;149;148;154;148;163;148;150;148 03:56:24 INFO - PID 12001 | |7;imaging-desaturate;99;94;94;99;94;95;95;102;96;101 03:56:24 INFO - PID 12001 | |8;json-parse-financial;55;61;53;54;54;53;52;52;53;53 03:56:24 INFO - PID 12001 | |9;json-stringify-tinderbox;38;40;48;38;47;40;37;38;44;42 03:56:24 INFO - PID 12001 | |10;stanford-crypto-aes;79;84;82;83;83;76;81;80;75;75 03:56:24 INFO - PID 12001 | |11;stanford-crypto-ccm;127;124;116;132;122;120;119;138;137;120 03:56:24 INFO - PID 12001 | |12;stanford-crypto-pbkdf2;174;184;168;174;172;174;170;175;172;170 03:56:24 INFO - PID 12001 | |13;stanford-crypto-sha256-iterative;73;69;63;64;68;71;65;73;71;72 03:56:24 INFO - PID 12001 | __end_tp_report 03:56:24 INFO - PID 12001 | __start_cc_report 03:56:24 INFO - PID 12001 | _x_x_mozilla_cycle_collect,948 03:56:24 INFO - PID 12001 | __end_cc_report 03:56:24 INFO - PID 12001 | __startTimestamp1504954584730__endTimestamp 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | ------- Summary: start ------- 03:56:24 INFO - PID 12001 | Number of tests: 14 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.98 (3.5%) stddev-sans-first:4.11 03:56:24 INFO - PID 12001 | Values: 116.0 111.0 115.0 109.0 111.0 108.0 112.0 114.0 121.0 117.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:124.00 stddev:8.12 (6.6%) stddev-sans-first:8.39 03:56:24 INFO - PID 12001 | Values: 118.0 119.0 128.0 122.0 116.0 143.0 126.0 118.0 117.0 126.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.50 stddev:4.07 (2.4%) stddev-sans-first:4.06 03:56:24 INFO - PID 12001 | Values: 162.0 172.0 163.0 163.0 170.0 169.0 171.0 163.0 164.0 162.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#3] audio-fft Cycles:10 Average:78.10 Median:78.50 stddev:2.92 (3.7%) stddev-sans-first:3.00 03:56:24 INFO - PID 12001 | Values: 76.0 83.0 79.0 76.0 74.0 78.0 75.0 81.0 78.0 81.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:81.00 stddev:3.16 (3.9%) stddev-sans-first:3.12 03:56:24 INFO - PID 12001 | Values: 85.0 79.0 88.0 79.0 80.0 80.0 81.0 81.0 85.0 79.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.33 (1.2%) stddev-sans-first:1.36 03:56:24 INFO - PID 12001 | Values: 116.0 115.0 115.0 115.0 114.0 115.0 115.0 117.0 112.0 116.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:149.50 stddev:4.74 (3.2%) stddev-sans-first:5.02 03:56:24 INFO - PID 12001 | Values: 150.0 148.0 149.0 148.0 154.0 148.0 163.0 148.0 150.0 148.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:95.00 stddev:3.07 (3.2%) stddev-sans-first:3.16 03:56:24 INFO - PID 12001 | Values: 99.0 94.0 94.0 99.0 94.0 95.0 95.0 102.0 96.0 101.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:2.62 (4.9%) stddev-sans-first:2.76 03:56:24 INFO - PID 12001 | Values: 55.0 61.0 53.0 54.0 54.0 53.0 52.0 52.0 53.0 53.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#9] json-stringify-tinderbox Cycles:10 Average:41.20 Median:41.00 stddev:3.94 (9.6%) stddev-sans-first:4.00 03:56:24 INFO - PID 12001 | Values: 38.0 40.0 48.0 38.0 47.0 40.0 37.0 38.0 44.0 42.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:81.50 stddev:3.43 (4.2%) stddev-sans-first:3.62 03:56:24 INFO - PID 12001 | Values: 79.0 84.0 82.0 83.0 83.0 76.0 81.0 80.0 75.0 75.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:125.50 stddev:7.75 (6.2%) stddev-sans-first:8.20 03:56:24 INFO - PID 12001 | Values: 127.0 124.0 116.0 132.0 122.0 120.0 119.0 138.0 137.0 120.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:4.37 (2.5%) stddev-sans-first:4.63 03:56:24 INFO - PID 12001 | Values: 174.0 184.0 168.0 174.0 172.0 174.0 170.0 175.0 172.0 170.0 03:56:24 INFO - PID 12001 | 03:56:24 INFO - PID 12001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:71.00 stddev:3.75 (5.3%) stddev-sans-first:3.68 03:56:24 INFO - PID 12001 | Values: 73.0 69.0 63.0 64.0 68.0 71.0 65.0 73.0 71.0 72.0 03:56:24 INFO - PID 12001 | -------- Summary: end -------- 03:56:24 INFO - PID 12001 | 03:56:25 INFO - PID 12001 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:56:25 INFO - TEST-INFO | 12001: exit 0 03:56:25 INFO - TEST-OK | kraken | took 63957ms 03:56:25 INFO - SUITE-END | took 1178s 03:56:25 INFO - Completed test suite (00:19:38) 03:56:25 INFO - javascript benchmark 03:56:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8438.39869770982, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.4741094014016, 3094.7524198064157, 3106.1458099022766, 3115.4703700370933, 3132.4361614909308, 6097.817065488042, 6247.187865577474, 6295.968520157398, 6310.68446577671, 6339.524535659821, 6134.785282515113, 6180.381961803829, 6227.532935029868, 6233.906491402633, 6245.500359971203, 5723.198752174699, 5740.052891272956, 5748.511376533, 5749.022666146744, 5777.306723193223, 5765.308163020443, 5799.246098007275, 5856.41435856413, 5861.58968872177, 5883.646981181143, 5777.682227477487, 5804.071348584227, 5819.592628516006, 5831.446012628793, 5869.471747542721, 5538.196961440609, 5639.802606908738, 5644.971775141098, 5752.712364381785, 5753.367129615739, 5699.800506982236, 5712.0860662293835, 5730.08318669011, 5776.075827867521, 5779.075347944351, 6065.423784740443, 6079.635221886657, 6224.906626400608, 6226.034964580497, 6231.439170474634, 6413.134226879358, 6492.448141907944, 6551.05009773585, 6626.503012274051, 6668.999650052482, 6653.567518111307, 6673.132492775908, 6717.865642687168, 6725.730970761164, 6732.2257940336995, 6126.509879209652, 6126.816195514097, 6147.815565533041, 6204.627722336629, 6234.0337247726675, 6771.8984215236815, 6777.2545020047755, 6822.863542729117, 6854.417374523122, 6870.896936545956, 6407.775727849503, 6495.610263384212, 6499.512536559682, 6499.8700025999215, 6522.478201743944, 6468.320826313264, 6505.0, 6513.739450422025, 6533.607983521004, 6578.111954886125, 6532.836679082966, 6622.304658010936, 6663.4669226461765, 6667.6666166691475, 6688.197416310074, 6629.635370054693, 6657.167854018247, 6712.295209003082, 6715.3620406061345, 6761.830954226085, 5238.68567885928, 5257.7896884124975, 5268.341457317835, 5275.920861187085, 5333.5199832015305, 4483.282674772021, 4518.344839998182, 4539.137563862855, 4548.6133678637025, 4634.165850147006, 5631.465010823965, 5685.943140568541, 5703.800366987136, 5711.514521265739, 5720.713964301768, 6710.563813352116, 6742.932570674328, 6752.054712340277, 6755.560888542229, 6766.086578311865, 5666.121751128581, 5674.943250567524, 5727.656340619576, 5737.311522617312, 5738.971305143447, 5614.747336369792, 5616.606837521416, 5683.914741278884, 5716.5998380113, 5770.0, 6445.355464453611, 6468.902966455507, 6469.28837827848, 6478.805635830932, 6506.3818937200895, 6704.329567043256, 6710.530262881552, 6725.730970761115, 6739.6967136478, 6772.898406523807, 6362.268339141058, 6420.518461115342, 6471.417572418505, 6530.640814755234, 6535.869282614416, 6376.234851817811, 6580.473562115115, 6603.9009414859775, 6676.83307917306, 6696.062551242927, 6591.670416479253, 6595.505337099833, 6654.933450665431, 6661.766838160641, 6716.664166791738, 6412.134361861089, 6471.2234531856475, 6496.382843630036, 6513.804585862432, 6516.152900122954, 6469.935300646934, 6482.384173503509, 6561.245456772533, 6565.540412171103, 6569.146011018537, 6238.126662267196, 6410.294867564658, 6482.611043337415, 6520.706568204537, 6520.902186467301, 6418.711157997995, 6470.255920569007, 6555.4427873631275, 6593.670316484253, 6609.636469994004, 6339.4928405726505, 6353.36466353361, 6367.108604795239, 6415.133956915756, 6434.227892652912], "value": 6065.582477492297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.3242670716841, 879.555824308724, 883.5140672630056, 888.991110088899, 890.3900827932866, 38062.23875522491, 38817.223655526876, 41049.58950410495, 41062.58937410629, 41349.379759303636, 38071.0, 38571.22857542855, 38690.41964370537, 38752.80623596878, 38820.80589597048, 6964.442844572434, 7154.570725756445, 7156.785296441115, 7159.64201789911, 7168.032315637374, 7017.82455438613, 7152.177499587536, 7167.3191046850725, 7169.6773645186095, 7171.497995140342, 7072.398846098088, 7117.608531530764, 7126.073610430637, 7132.964335178317, 7144.214136444987, 7089.858202835941, 7641.3122818946285, 7865.488743231672, 7868.72459463916, 7887.0, 7769.7669069928, 7821.648025838851, 7842.29419352261, 7845.411594130463, 7845.803854903673, 37807.810960945295, 38181.0, 38350.0, 39432.0, 40489.0, 3538.575370955476, 3600.8559657613664, 3600.945985810215, 3604.891853244381, 3604.945925811115, 32573.83713081443, 32585.18537036593, 32615.51076733851, 32651.0, 32721.34557308864, 5178.482151784829, 5197.8440646780655, 5225.268462415265, 5255.947440525584, 5298.046351656701, 186333.0, 187718.0, 189450.0, 190140.0, 190527.0, 42357.57642423598, 43098.0, 49251.50748492541, 50036.249456258185, 50169.0, 44550.55449445529, 51312.486875131515, 51604.74197628988, 51805.48194518082, 51879.740601296755, 16309.184540772914, 16314.510564683078, 16495.587610309598, 16526.83473165277, 16545.420910268083, 13482.988775841852, 13534.93232533831, 13572.524961626295, 13610.59168224955, 13620.0, 13926.303684815719, 14149.434022639185, 14165.0, 14242.572722818331, 14271.286435678174, 5816.88366232673, 5842.561807864342, 5941.524678025748, 5951.196588460589, 6045.3652366501765, 1011.8026984737905, 1035.4563853976572, 1041.6406339812752, 1042.5048102151568, 1043.8225501664735, 23184.884075579852, 23403.297901062655, 23429.41426464318, 23514.529709405717, 23641.054357825495, 1136.5681041204289, 1141.4463984967285, 1142.2232881640564, 1142.5601143559622, 1146.6789298996293, 12340.50637974471, 12425.0, 12497.18768280059, 12633.178843375152, 12701.0, 224315.0, 225846.0, 226032.0, 226550.0, 226588.0, 52323.0, 52382.21426678603, 52410.737946310786, 52579.21131183035, 53090.20364694532, 1431.51328548292, 1478.3273610507408, 1491.671832196915, 1502.9248537573078, 1509.5697726147996, 22964.540709186058, 22970.19604313841, 23024.884875576186, 23067.307980760605, 23073.423164421023, 36818.26363472769, 37180.25639487141, 37263.0, 37265.0683732898, 37290.62709372872, 189234.0, 191245.0, 191512.0, 191871.0, 192136.0, 33825.661743383236, 34171.46228419677, 35361.0, 35409.64590354166, 35522.467162993096, 44710.3293450605, 45656.0, 46203.0, 46406.0, 46451.53548464472, 32894.842063173965, 32974.67025329716, 33063.33873322568, 33169.50245746267, 33311.50032749462, 32699.0, 32788.0, 32815.671843282216, 32940.34119317648, 33000.834995824865, 36221.0, 37116.443253350684, 37864.242715146094, 38074.8096259528, 38253.80873095617, 32032.0, 32603.673963260062, 32739.836300818344, 33050.33899322048, 33085.83457082699, 23528.41178970471, 23974.76025239795, 24759.752402476464, 24817.0, 24830.751692482845], "value": 17206.521424928775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2736233939386, 569.1207085053592, 573.5411670663469, 574.8591595059206, 580.8112363481869, 22519.774802251974, 23037.078516859325, 23192.8840355798, 23286.76713232867, 23312.184073557386, 23162.536749265004, 24217.152399666014, 24264.02943882247, 24507.0, 24547.0, 6233.906491402633, 6481.675916204194, 6514.837129071764, 6524.15186025816, 6566.310537393577, 6414.454771344442, 6527.41253287204, 6528.281888992231, 6529.640869752162, 6530.053142294364, 6190.226221722285, 6404.487640988733, 6459.5478316517865, 6479.2224933007865, 6493.837654058639, 6447.677616119176, 6473.546851720382, 6504.414602685781, 6518.771842985473, 6519.902201466982, 5840.678762668052, 6010.8497287567725, 6088.0, 6092.603980741238, 6105.297890742577, 28783.0, 29042.0, 29396.0, 29427.0, 29468.11595652134, 2032.9186832526682, 2080.4278823323557, 2093.194120263694, 2094.98952505238, 2105.1684584589157, 18736.718949215774, 19357.0, 19643.410697679094, 19661.213551458066, 19845.801541984685, 2366.7396586375485, 2396.880155992211, 2435.0259896041725, 2440.389902524369, 2440.4996975619956, 117148.41425792816, 126226.0, 126238.0, 131728.0, 135880.0, 14256.215908125152, 14263.85736142646, 14379.609162575092, 14398.20809855447, 14466.855331446552, 22792.544149116926, 22845.771542284696, 22874.199403021146, 22916.656250156262, 22925.88537057304, 9752.707418777449, 9980.2514811388, 10097.242706796873, 10144.898551014543, 10253.84619230712, 9376.29677774156, 9461.76345591352, 9558.0, 9585.616575337048, 9607.13535781783, 8618.224359807522, 8741.30069594431, 8904.510251936206, 8912.598933048028, 8970.058143894928, 2712.742289482496, 2723.101376545735, 2737.986310068437, 2761.7514423701964, 2764.875580598878, 954.1174413667469, 972.8443449048118, 974.7465658928729, 974.7514383832078, 977.379364103785, 18808.905955470407, 19269.518262043563, 19288.8071119287, 19392.515187120152, 19603.8039619602, 1011.8161402600155, 1013.7668336282549, 1014.9086582207489, 1021.6271061062658, 1034.963776267827, 10524.789504209873, 10732.356058636507, 10857.457127143769, 10864.511097000654, 10941.070009049161, 427136.0, 431591.0, 444167.0, 444971.0, 445661.0, 108099.45950270198, 108190.0, 108235.0, 109955.0, 110196.44901775439, 1034.6016783538391, 1066.9839952400564, 1113.6046703420332, 1138.4023387721347, 1172.3083380805365, 18793.90603046976, 19729.309474168334, 20115.899420502803, 20306.69539956872, 20456.59086818285, 53314.0, 55935.0, 56521.43478565162, 56579.43420565906, 56693.0, 69973.30026699668, 70139.64930175521, 70355.64822175856, 70800.64599676969, 71324.64337678278, 14044.78932815988, 14216.431342746175, 14241.857581424467, 14385.568432947028, 14417.711645766816, 22415.43961400978, 22567.435814104778, 22569.0, 22586.887065564566, 23031.424214394774, 17887.28450861951, 18043.09784510743, 18188.727169092737, 18195.272189112817, 18422.63154736871, 15141.394344226108, 15274.694506109594, 15904.681906361577, 15953.840461595235, 16622.25199865985, 18438.35465758692, 18546.536336591693, 18575.0, 18716.438506844817, 18856.622867542847, 13962.301884905917, 14114.717705646035, 14115.153090814583, 14185.148891066568, 14194.290285485478, 17521.561960950567, 17829.0, 17880.0, 18106.275748969892, 18175.45508631728], "value": 11762.904143927102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.5547513845293, 1370.49291762048, 1383.2323060701306, 1383.6333371656506, 1397.1756663568497, 14712.558623241306, 15932.681346373065, 15976.680466390666, 15985.600359991005, 15989.360425582978, 15715.135667538309, 15817.60455988598, 15853.682926341495, 15900.284487198074, 16012.43956461524, 2759.089500464852, 2816.070696670094, 2816.3944751878344, 2828.75955543778, 2831.207261966653, 2685.1273336165727, 2742.0676969830256, 2761.585762135686, 2763.2539214412195, 2766.0595397564825, 2664.3472349274457, 2713.6743590769133, 2729.113038262563, 2737.466194092153, 2885.321949341903, 2782.0541016054535, 2850.2874281429645, 2850.5296626056675, 2852.115844088339, 2852.614896988901, 2717.5244332241778, 2724.1691284158323, 2754.5730411786203, 2760.8481533515646, 2766.0871912268904, 14910.552683419515, 14968.850311496855, 15271.465498707492, 15435.614109647237, 15499.845001549953, 8070.192980701941, 8382.497050176948, 8419.07390187079, 8421.452605580618, 8426.536540490271, 5478.58910581704, 5670.0, 5706.087026075849, 5731.168980497846, 5749.770009199627, 1916.3101283537915, 1936.5836345185853, 1951.5706544560173, 1970.5861769028522, 2009.577988622391, 26277.08030218933, 26570.0, 26596.86701566499, 26612.86693566539, 26621.60067598968, 6722.361375669304, 6897.137772801316, 6912.447004239649, 6922.896156557656, 7098.858022839618, 17128.14359282031, 17138.31446742116, 17144.828551714574, 17163.141842907804, 17183.65632687339, 7886.526808391515, 8050.396220283502, 8052.194780522018, 8055.959720201478, 8064.233897779702, 7253.419726421874, 7268.45486588508, 7371.115466144097, 7439.702411903571, 7518.812029699192, 5246.816361427332, 5300.045991721528, 5423.5932305076485, 5460.863478413072, 5472.50747432733, 1470.6176394137387, 1487.1746180869504, 1510.0, 1511.2292730707418, 1538.4384699584796, 885.7874110213502, 900.7838118851429, 910.3763921713647, 912.6030176873081, 921.3366376209119, 7680.577568233801, 7685.154632990367, 7702.8844567331535, 7815.4529182957785, 8250.257476826995, 667.1926968368329, 701.8140192848899, 705.9047028651066, 706.6855249414065, 707.1443553300461, 4789.521047895252, 5032.572231360376, 5100.923486147711, 5154.098032844237, 5221.0, 21055.157793688388, 21708.674369884466, 21716.45708857291, 22041.338759837232, 22068.33794986121, 20515.589688206153, 21321.0, 21537.892310538347, 21556.245531406326, 21805.67291490629, 10942.890571094187, 10947.945260273647, 11152.386618735885, 11306.773864522664, 11326.603568875049, 8386.077531471412, 8510.106438823834, 8524.232819046316, 8529.658813647384, 8597.355198360274, 18102.637947240717, 18118.0, 18279.26882924668, 18394.0, 18606.627867442847, 18554.81445185531, 19105.90447047756, 19141.80858191456, 19155.521111972314, 19737.210511579375, 11006.779864402506, 11089.5564177432, 11264.211505194558, 11271.661850144508, 11273.267237629529, 13253.13854599448, 13318.933405332911, 13503.12229705066, 13580.185188888698, 13593.252371119683, 10589.152867770714, 10707.464626768786, 10747.516361763583, 10817.513211905325, 10918.454077295944, 10869.836952445878, 11094.889051109709, 11231.21381503287, 11234.269772464764, 11416.372099534605, 9099.863502047343, 9293.581788819383, 9329.11373419524, 9329.813403732023, 9342.159205671522, 7429.479936404616, 7540.547567145989, 7635.923640763744, 7656.042994625672, 7668.923310767044, 7250.927490725026, 7429.851402972018, 7500.512466689648, 7523.699052037857, 7530.134034585873], "value": 6657.811304205724, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.9502041629319, 504.67317464165717, 511.5958392869633, 521.1011006014622, 528.5480913818685, 6208.1308616793685, 6304.807303143416, 6320.30476647569, 6385.968070159648, 6416.262129855062, 6194.535409844257, 6198.566100372976, 6200.968995155029, 6221.284552276489, 6232.189815324013, 5121.487851214886, 5175.8188463403785, 5178.766955487003, 5210.426853046162, 5219.947800521984, 5147.71687557186, 5168.2764412982215, 5176.66351687141, 5215.478452154792, 5231.398389185254, 4827.927581086286, 4887.853364399056, 4890.193118135503, 4974.77613507393, 5151.5878729701535, 4913.975430122827, 4969.577585905203, 4974.204127339626, 4980.900381992376, 5021.14640511114, 4425.137098265839, 4445.8221671133115, 4452.955470445287, 4471.910561788779, 4485.416895803524, 5886.676232807236, 6046.576739628228, 6078.848028799272, 6118.4799292060225, 6152.415520525543, 5550.5282051025715, 5571.665700057969, 5607.495325420732, 5621.8594535136535, 5649.180868774046, 6512.706928188243, 6540.084388185658, 6571.408573228432, 6586.835329116762, 6639.634820084893, 4572.0568758277595, 4735.266033764772, 4783.880402989953, 4825.469198388175, 4826.913944362525, 6688.531802773857, 6701.855406269947, 6730.865382692367, 6750.223724271723, 6756.493263005245, 4964.709175614366, 4976.029674213493, 4984.90030199394, 4995.425526064549, 5025.547700706881, 5004.899902001939, 5006.173981293119, 5020.949790502122, 5025.974870125699, 5074.112030394666, 5542.7782888684005, 5614.63504872182, 5644.407337229532, 5681.9431805681415, 5687.914681279784, 6508.420368797143, 6545.312742162099, 6591.769288074895, 6601.3068627794355, 6678.666066696645, 1725.9730460376306, 1736.7047601907707, 1759.6304775997185, 1766.9823301767076, 1770.8140645232065, 1146.1174895330716, 1206.8414322250562, 1215.3072748533252, 1222.10175520992, 1223.431104536377, 5563.3031925263185, 5594.300712410949, 5622.690752008679, 5702.460335709336, 5714.79998200061, 6643.634600097041, 6646.069550262967, 6660.833479162963, 6757.425618822455, 6762.985552167214, 5606.673230609333, 5697.971510142505, 5715.0, 5728.713564321767, 5739.16782066598, 3486.8430920608635, 3550.715942724576, 3552.5381700378784, 3561.8397172127316, 3580.695640870503, 6382.32985536512, 6450.258220304631, 6469.191351081115, 6495.642739649365, 6506.25178104524, 6849.383555480031, 6853.280405557444, 6902.654867256617, 6909.2745261746795, 6968.0, 6091.9695401523595, 6423.008867251167, 6525.3474652535315, 6528.640924749185, 6580.309067547934, 6547.836304092436, 6569.178852643419, 6601.3728695773825, 6664.866702666017, 6711.798646040431, 6568.770093046721, 6620.867582648224, 6637.900431493628, 6649.038533632687, 6707.862305990159, 6259.436650701276, 6348.968255158879, 6353.680906469198, 6392.872142557216, 6429.324920883427, 4929.7535123244415, 4958.983408401341, 4980.975095124501, 4992.126377883928, 5039.067772462106, 6528.857449946336, 6658.733650654113, 6670.66646667655, 6805.570830125729, 6841.555298905555, 6268.122462855295, 6395.993882875041, 6462.289148193601, 6476.481881449378, 6516.250631177286, 6474.320196379501, 6534.771283005072, 6543.051257567721, 6559.4752419805345, 6561.409473147249, 6346.2067241594805, 6391.2330520337855, 6441.3880681335195, 6489.8702025960165, 6516.771912983023, 6550.803475895731, 6578.914504083799, 6579.111819904251, 6606.4384527315715, 6665.833354166185, 6389.648569328731, 6418.614883107029, 6433.324500927522, 6458.838529036811, 6471.773487928088], "value": 5040.085216149487, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.7114937645265, 890.7684002159436, 907.6596276396356, 919.747069555872, 933.8599210118483, 17400.0, 18364.44906652801, 18365.173567189475, 18416.631667366644, 18447.44657660269, 14863.92568037161, 14888.330025148867, 14914.403423863032, 14976.026558273705, 17299.481015569523, 943.094629156011, 962.7737481691797, 963.335298643937, 964.2237998411312, 966.3960024984385, 975.4537459022935, 977.1254727019314, 978.7553111722069, 979.4319294809029, 979.6962941488126, 975.5024937281967, 1031.2471895516278, 1037.8183817831887, 1039.6257347354947, 1039.7868436970402, 1010.711947095078, 1016.6187679620142, 1022.2384323678907, 1022.9999999999962, 1023.8976102389776, 721.5995122706895, 741.907261592301, 746.8319628083638, 752.0, 752.0336367767447, 18611.906940465346, 18727.719084213746, 18738.718919216088, 18812.341568045053, 18882.150303236387, 21370.0, 21372.893135534378, 22261.777382226133, 22370.105195792148, 22506.43733906649, 17277.0, 17698.292068317252, 17840.732389014174, 17840.821591784046, 17875.73186402205, 3750.1562148516637, 3801.657850793414, 3802.315583195024, 3802.524684414448, 3803.315403227418, 136985.0, 138790.0, 140128.0, 140876.99999999898, 141012.0, 16485.423010194587, 16727.414540491023, 16729.91635041817, 16921.323147073977, 16922.74615880763, 31067.378652426825, 32171.195720106716, 32191.195220119684, 32278.83860580682, 32383.0, 7944.761657150295, 7948.403869709795, 8005.759827205193, 8020.759377218693, 8035.357171426389, 3747.2505498900327, 3761.6614504694708, 3771.30230907283, 3779.4897688812207, 3828.1769419574366, 5322.201669749568, 5379.462053794589, 5399.406065332811, 5431.131019036935, 5444.3194600674915, 984.7390441532999, 1011.600417834951, 1026.199564339816, 1033.6743925663393, 1037.2998226197287, 687.3161204601454, 698.179638924262, 707.7699747582056, 717.5730440387961, 723.6580516898608, 11340.376279304717, 11673.357965311989, 11675.591354302729, 12494.06294527914, 12572.0, 674.3189378727423, 680.6562685843618, 683.7265093962454, 690.8203866994618, 699.1784653032666, 5573.7770489179975, 5614.129809879475, 5621.690807005654, 5646.71766411686, 5753.252077229933, 123879.3806030964, 124036.37981810034, 127041.0, 129585.35207323903, 129765.35117324353, 110141.0, 110327.0, 110577.44711276393, 111155.44422277837, 115837.0, 89767.0, 90195.54902225579, 91163.54418227867, 91985.0, 93444.53277733568, 10056.64801731936, 10148.238882083726, 10205.74485637865, 10279.486025698536, 10305.484725763832, 43538.34692479552, 44131.77934110309, 44257.778711106235, 45598.772006139756, 46625.06749865052, 56935.43064569301, 57599.71200143972, 58050.709746451, 59889.401105988385, 60054.39945600488, 15241.466548670744, 15936.601584960004, 15944.36222551085, 15992.92003539975, 16096.67806643884, 16333.918330408273, 17085.48743537696, 17255.65488690194, 17362.73955890688, 17508.124593770004, 14623.707525849637, 14940.701185976002, 15169.620759481102, 15254.694906102039, 15396.84603153954, 14296.785548216578, 14307.57077287683, 14464.20446875432, 14545.200013998909, 14603.123812571279, 14272.643183920485, 14387.640308992359, 14543.85456145425, 14640.487582934546, 14816.036957597722, 11755.471003804678, 12041.578544750892, 12050.457729402022, 12057.216280941711, 12261.938690306491, 11255.943720281673, 11347.48936297852, 11487.25332853362, 11551.711207219887, 12025.037996960396], "value": 8763.645952473767, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 115.0, 109.0, 111.0, 108.0, 112.0, 114.0, 121.0, 117.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 128.0, 122.0, 116.0, 143.0, 126.0, 118.0, 117.0, 126.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 172.0, 163.0, 163.0, 170.0, 169.0, 171.0, 163.0, 164.0, 162.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 79.0, 76.0, 74.0, 78.0, 75.0, 81.0, 78.0, 81.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 88.0, 79.0, 80.0, 80.0, 81.0, 81.0, 85.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 117.0, 112.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 148.0, 154.0, 148.0, 163.0, 148.0, 150.0, 148.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 99.0, 94.0, 95.0, 95.0, 102.0, 96.0, 101.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 53.0, 54.0, 54.0, 53.0, 52.0, 52.0, 53.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 40.0, 48.0, 38.0, 47.0, 40.0, 37.0, 38.0, 44.0, 42.0], "value": 41.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 82.0, 83.0, 83.0, 76.0, 81.0, 80.0, 75.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 116.0, 132.0, 122.0, 120.0, 119.0, 138.0, 137.0, 120.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 184.0, 168.0, 174.0, 172.0, 174.0, 170.0, 175.0, 172.0, 170.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 63.0, 64.0, 68.0, 71.0, 65.0, 73.0, 71.0, 72.0], "value": 68.9, "unit": "score"}]}]} 03:56:25 INFO - Return code: 0 03:56:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:25 INFO - # TBPL SUCCESS # 03:56:25 INFO - Running post-action listener: _package_coverage_data 03:56:25 INFO - Running post-action listener: _resource_record_post_action 03:56:25 INFO - [mozharness: 2017-09-09 10:56:25.982934Z] Finished run-tests step (success) 03:56:25 INFO - Running post-run listener: _resource_record_post_run 03:56:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5017600; Write bytes: 305549312; Read time: 7952; Write time: 224380 03:56:26 INFO - TinderboxPrint: CPU usage
13.3% 03:56:26 INFO - TinderboxPrint: I/O read bytes / time
5,017,600 / 7,952 03:56:26 INFO - TinderboxPrint: I/O write bytes / time
305,549,312 / 224,380 03:56:26 INFO - TinderboxPrint: CPU idle
8,257.1 (86.7%) 03:56:26 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 03:56:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12607488; Read time: 0; Write time: 1888 03:56:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:56:26 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5017600; Write bytes: 292327424; Read time: 7952; Write time: 222492 03:56:26 INFO - Running post-run listener: _upload_blobber_files 03:56:26 INFO - Blob upload gear active. 03:56:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:56:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:56:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:27 INFO - (blobuploader) - INFO - Done attempting. 03:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:29 INFO - (blobuploader) - INFO - Done attempting. 03:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:36 INFO - (blobuploader) - INFO - Done attempting. 03:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:37 INFO - (blobuploader) - INFO - Done attempting. 03:56:37 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:37 INFO - Return code: 0 03:56:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f04eb4dcf37990ac8e76c0a94928d61f0e733648031ad86f0ea75dc04e1cecf1939664ca57b2f81865b592737956613f1deaecd1d921fc7d6b0c9506b28e4ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce0a96f7f0f9d0bd519dd543b4bf75c413187a3a21019fe840db3e6d5c907462bd9d22b6f2f4e3e3fb26e866dccb621be4489dcc56cf4247b682f8f5de19139", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cadca5822de792ebb56f7be5b771ce588ae5c65eb4f5ecc6d360495deabd938c02764e4833b7965fa75b55039fa2f060359823eb5ff158a01af144ae261305", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccea162d5ff34bddd90010d67a3175b91d0e48366a647c8cb0028b091b2671cc08036588182aaa732a476582c34bcd71e433789797af31b09d71196b9024605a"} 03:56:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:37 INFO - Contents: 03:56:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f04eb4dcf37990ac8e76c0a94928d61f0e733648031ad86f0ea75dc04e1cecf1939664ca57b2f81865b592737956613f1deaecd1d921fc7d6b0c9506b28e4ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce0a96f7f0f9d0bd519dd543b4bf75c413187a3a21019fe840db3e6d5c907462bd9d22b6f2f4e3e3fb26e866dccb621be4489dcc56cf4247b682f8f5de19139", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cadca5822de792ebb56f7be5b771ce588ae5c65eb4f5ecc6d360495deabd938c02764e4833b7965fa75b55039fa2f060359823eb5ff158a01af144ae261305", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccea162d5ff34bddd90010d67a3175b91d0e48366a647c8cb0028b091b2671cc08036588182aaa732a476582c34bcd71e433789797af31b09d71196b9024605a"} 03:56:37 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:37 INFO - Copying logs to upload dir... 03:56:37 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.016971 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-09 03:56:37.993415) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 03:56:37.998344) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f04eb4dcf37990ac8e76c0a94928d61f0e733648031ad86f0ea75dc04e1cecf1939664ca57b2f81865b592737956613f1deaecd1d921fc7d6b0c9506b28e4ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce0a96f7f0f9d0bd519dd543b4bf75c413187a3a21019fe840db3e6d5c907462bd9d22b6f2f4e3e3fb26e866dccb621be4489dcc56cf4247b682f8f5de19139", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cadca5822de792ebb56f7be5b771ce588ae5c65eb4f5ecc6d360495deabd938c02764e4833b7965fa75b55039fa2f060359823eb5ff158a01af144ae261305", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccea162d5ff34bddd90010d67a3175b91d0e48366a647c8cb0028b091b2671cc08036588182aaa732a476582c34bcd71e433789797af31b09d71196b9024605a"} build_url:https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/NAT5dUiYQCyr_at2cW6x4A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f04eb4dcf37990ac8e76c0a94928d61f0e733648031ad86f0ea75dc04e1cecf1939664ca57b2f81865b592737956613f1deaecd1d921fc7d6b0c9506b28e4ed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dce0a96f7f0f9d0bd519dd543b4bf75c413187a3a21019fe840db3e6d5c907462bd9d22b6f2f4e3e3fb26e866dccb621be4489dcc56cf4247b682f8f5de19139", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6cadca5822de792ebb56f7be5b771ce588ae5c65eb4f5ecc6d360495deabd938c02764e4833b7965fa75b55039fa2f060359823eb5ff158a01af144ae261305", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccea162d5ff34bddd90010d67a3175b91d0e48366a647c8cb0028b091b2671cc08036588182aaa732a476582c34bcd71e433789797af31b09d71196b9024605a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 03:56:38.031534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:56:38.031959) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504953155.283894-248187345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 03:56:38.113033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 03:56:38.113358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 03:56:38.113754) ========= ========= Total master_lag: 0.47 =========