builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1501324444.87 results: success (0) revision: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:04.871342) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:04.871928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:04.872192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:05.991817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:05.992088) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-29 03:34:06-- 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% 54.6M=0s 2017-07-29 03:34:06 (54.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131873 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:06.278560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:06.278858) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019365 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:06.313322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:06.313615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 --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 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 --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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-29 03:34:06,991 truncating revision to first 12 chars 2017-07-29 03:34:06,991 Setting DEBUG logging. 2017-07-29 03:34:06,991 attempt 1/10 2017-07-29 03:34:06,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fba314d7de7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-29 03:34:07,849 unpacking tar archive at: mozilla-central-2fba314d7de7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.175848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:07.507772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:07.508065) ========= script_repo_revision: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:07.508483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:07.508753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:07.517495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-29 03:34:07.517771) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:08 INFO - MultiFileLogger online at 20170729 03:34:08 in /builds/slave/test 03:34:08 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:34:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:08 INFO - {'append_to_log': False, 03:34:08 INFO - 'base_work_dir': '/builds/slave/test', 03:34:08 INFO - 'blob_upload_branch': 'Firefox', 03:34:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:08 INFO - 'branch': 'Firefox', 03:34:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:08 INFO - 'code_coverage': False, 03:34:08 INFO - 'config_files': ('talos/linux_config.py',), 03:34:08 INFO - 'default_actions': ('clobber', 03:34:08 INFO - 'read-buildbot-config', 03:34:08 INFO - 'download-and-extract', 03:34:08 INFO - 'populate-webroot', 03:34:08 INFO - 'create-virtualenv', 03:34:08 INFO - 'install', 03:34:08 INFO - 'setup-mitmproxy', 03:34:08 INFO - 'run-tests'), 03:34:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:08 INFO - 'disable_ccov_upload': False, 03:34:08 INFO - 'download_minidump_stackwalk': True, 03:34:08 INFO - 'download_symbols': 'ondemand', 03:34:08 INFO - 'enable_stylo': False, 03:34:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:08 INFO - 'gecko_profile': False, 03:34:08 INFO - 'gecko_profile_interval': 0, 03:34:08 INFO - 'installer_path': 'installer.exe', 03:34:08 INFO - 'log_level': 'info', 03:34:08 INFO - 'log_name': 'talos', 03:34:08 INFO - 'log_to_console': True, 03:34:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:08 INFO - 'opt_config_files': (), 03:34:08 INFO - 'pip_index': False, 03:34:08 INFO - 'suite': 'dromaeojs-e10s', 03:34:08 INFO - 'system_bits': '32', 03:34:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:08 INFO - 'title': 'talos-linux64-ix-019', 03:34:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:08 INFO - 'use_talos_json': True, 03:34:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:08 INFO - 'work_dir': 'build'} 03:34:08 INFO - [mozharness: 2017-07-29 10:34:08.375422Z] Running clobber step. 03:34:08 INFO - Running pre-action listener: _resource_record_pre_action 03:34:08 INFO - Running main action method: clobber 03:34:08 INFO - rmtree: /builds/slave/test/build 03:34:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:09 INFO - Running post-action listener: _resource_record_post_action 03:34:09 INFO - [mozharness: 2017-07-29 10:34:09.362938Z] Finished clobber step (success) 03:34:09 INFO - [mozharness: 2017-07-29 10:34:09.363041Z] Running read-buildbot-config step. 03:34:09 INFO - Running pre-action listener: _resource_record_pre_action 03:34:09 INFO - Running main action method: read_buildbot_config 03:34:09 INFO - Using buildbot properties: 03:34:09 INFO - { 03:34:09 INFO - "project": "", 03:34:09 INFO - "product": "firefox", 03:34:09 INFO - "who": "archaeopteryx@coole-files.de", 03:34:09 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:34:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:09 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:34:09 INFO - "stage_platform": "linux64-stylo", 03:34:09 INFO - "basedir": "/builds/slave/test", 03:34:09 INFO - "buildnumber": 9, 03:34:09 INFO - "platform": "ubuntu64_hw_stylo", 03:34:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:34:09 INFO - "slavebuilddir": "test", 03:34:09 INFO - "taskId": "BXN4kUWBSmiZSsUPM4tYTQ", 03:34:09 INFO - "branch": "mozilla-central", 03:34:09 INFO - "script_repo_revision": "production", 03:34:09 INFO - "revision": "2fba314d7de77ad8ab693a2ea0112c0cda5dd564", 03:34:09 INFO - "slavename": "talos-linux64-ix-019", 03:34:09 INFO - "repo_path": "mozilla-central" 03:34:09 INFO - } 03:34:09 INFO - Finding installer, test and symbols from parent task. 03:34:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXN4kUWBSmiZSsUPM4tYTQ'}, attempt #1 03:34:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXN4kUWBSmiZSsUPM4tYTQ'}, attempt #1 03:34:10 INFO - Task dependencies: H5ScIwu-Qs6tguCScglFqQ 03:34:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ'}, attempt #1 03:34:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/test_packages.json 03:34:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip 03:34:10 INFO - Running post-action listener: _resource_record_post_action 03:34:10 INFO - [mozharness: 2017-07-29 10:34:10.712315Z] Finished read-buildbot-config step (success) 03:34:10 INFO - [mozharness: 2017-07-29 10:34:10.712632Z] Running download-and-extract step. 03:34:10 INFO - Running pre-action listener: _resource_record_pre_action 03:34:10 INFO - Running main action method: download_and_extract 03:34:10 INFO - mkdir: /builds/slave/test/build/tests 03:34: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:34:10 INFO - trying https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json 03:34:10 INFO - Downloading https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:11 INFO - Downloaded 989 bytes. 03:34:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:11 INFO - Using the following test package requirements: 03:34:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:11 INFO - u'common': [u'target.common.tests.zip'], 03:34:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:11 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:11 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:11 INFO - u'target.web-platform.tests.tar.gz'], 03:34:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip 03:34:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:11 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip into memory 03:34:12 INFO - Content-Length response header: 72567847 03:34:12 INFO - Bytes received: 72567847 03:34:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip 03:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip into memory 03:34:25 INFO - Content-Length response header: 72567847 03:34:25 INFO - Bytes received: 72567847 03:34:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip 03:34:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:38 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip into memory 03:34:39 INFO - Content-Length response header: 14496686 03:34:39 INFO - Bytes received: 14496686 03:34:39 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:34:39 INFO - trying https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:39 INFO - Downloading https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:40 INFO - Downloaded 62119037 bytes. 03:34:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:40 INFO - mkdir: /builds/slave/test/properties 03:34:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:40 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:40 INFO - Contents: 03:34:40 INFO - build_url:https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:40 INFO - Running post-action listener: _resource_record_post_action 03:34:40 INFO - Running post-action listener: set_extra_try_arguments 03:34:40 INFO - [mozharness: 2017-07-29 10:34:40.627571Z] Finished download-and-extract step (success) 03:34:40 INFO - [mozharness: 2017-07-29 10:34:40.627668Z] Running populate-webroot step. 03:34:40 INFO - Running pre-action listener: _resource_record_pre_action 03:34:40 INFO - Running main action method: populate_webroot 03:34:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:40 INFO - 'tests': ['damp', 'tps']}, 03:34:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:40 INFO - 'ts_paint', 03:34:40 INFO - 'tpaint', 03:34:40 INFO - 'sessionrestore', 03:34:40 INFO - 'sessionrestore_many_windows', 03:34:40 INFO - 'sessionrestore_no_auto_restore', 03:34:40 INFO - 'tabpaint']}, 03:34:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:40 INFO - 'talos_options': ['--mitmproxy', 03:34:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:40 INFO - '--firstNonBlankPaint'], 03:34:40 INFO - 'tests': ['quantum_pageload_google', 03:34:40 INFO - 'quantum_pageload_youtube', 03:34:40 INFO - 'quantum_pageload_amazon', 03:34:40 INFO - 'quantum_pageload_facebook']}, 03:34:40 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:40 INFO - 'talos_options': ['--stylo', 03:34:40 INFO - '--mitmproxy', 03:34:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:40 INFO - '--firstNonBlankPaint'], 03:34:40 INFO - 'tests': ['quantum_pageload_google', 03:34:40 INFO - 'quantum_pageload_youtube', 03:34:40 INFO - 'quantum_pageload_amazon', 03:34:40 INFO - 'quantum_pageload_facebook']}, 03:34:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:40 INFO - 'tsvgr_opacity', 03:34:40 INFO - 'tart', 03:34:40 INFO - 'tscrollx', 03:34:40 INFO - 'cart', 03:34:40 INFO - 'tsvg_static']}, 03:34:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:40 INFO - 'talos_options': ['--stylo', 03:34:40 INFO - '--stylo-threads=1', 03:34:40 INFO - '--mitmproxy', 03:34:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:40 INFO - '--firstNonBlankPaint'], 03:34:40 INFO - 'tests': ['tp6_google', 03:34:40 INFO - 'tp6_youtube', 03:34:40 INFO - 'tp6_amazon', 03:34:40 INFO - 'tp6_facebook']}, 03:34:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:40 INFO - 'talos_options': ['--xperf_path', 03:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:40 INFO - 'tests': ['tp5n']}}} 03:34:40 INFO - Running post-action listener: _resource_record_post_action 03:34:40 INFO - [mozharness: 2017-07-29 10:34:40.636454Z] Finished populate-webroot step (success) 03:34:40 INFO - [mozharness: 2017-07-29 10:34:40.636545Z] Running create-virtualenv step. 03:34:40 INFO - Running pre-action listener: _resource_record_pre_action 03:34:40 INFO - Running main action method: create_virtualenv 03:34:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:40 INFO - Using real prefix '/usr' 03:34:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:43 INFO - Installing pip.................done. 03:34:43 INFO - Return code: 0 03:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:43 INFO - Reading from file tmpfile_stdout 03:34:43 INFO - Output received: 03:34:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:34:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:43 INFO - Using env: {'DISPLAY': ':0', 03:34:43 INFO - 'HOME': '/home/cltbld', 03:34:43 INFO - 'LANG': 'en_US.UTF-8', 03:34:43 INFO - 'LANGUAGE': 'en_US:en', 03:34:43 INFO - 'LOGNAME': 'cltbld', 03:34:43 INFO - 'MAIL': '/var/mail/cltbld', 03:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:43 INFO - 'MOZ_NO_REMOTE': '1', 03:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:43 INFO - 'NO_EM_RESTART': '1', 03:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:43 INFO - 'PWD': '/builds/slave/test', 03:34:43 INFO - 'SHELL': '/bin/bash', 03:34:43 INFO - 'SHLVL': '1', 03:34:43 INFO - 'TERM': 'linux', 03:34:43 INFO - 'TMOUT': '86400', 03:34:43 INFO - 'USER': 'cltbld', 03:34:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:43 INFO - '_': '/tools/buildbot/bin/python'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:43 INFO - Cleaning up... 03:34:43 INFO - Return code: 0 03:34:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:43 INFO - Using env: {'DISPLAY': ':0', 03:34:43 INFO - 'HOME': '/home/cltbld', 03:34:43 INFO - 'LANG': 'en_US.UTF-8', 03:34:43 INFO - 'LANGUAGE': 'en_US:en', 03:34:43 INFO - 'LOGNAME': 'cltbld', 03:34:43 INFO - 'MAIL': '/var/mail/cltbld', 03:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:43 INFO - 'MOZ_NO_REMOTE': '1', 03:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:43 INFO - 'NO_EM_RESTART': '1', 03:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:43 INFO - 'PWD': '/builds/slave/test', 03:34:43 INFO - 'SHELL': '/bin/bash', 03:34:43 INFO - 'SHLVL': '1', 03:34:43 INFO - 'TERM': 'linux', 03:34:43 INFO - 'TMOUT': '86400', 03:34:43 INFO - 'USER': 'cltbld', 03:34:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:43 INFO - '_': '/tools/buildbot/bin/python'} 03:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:44 INFO - Downloading/unpacking psutil>=3.1.1 03:34:44 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:34:44 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:34:44 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:34:44 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:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:45 INFO - Installing collected packages: psutil 03:34:45 INFO - Running setup.py install for psutil 03:34:45 INFO - building 'psutil._psutil_linux' extension 03:34:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:46 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:34:46 INFO - building 'psutil._psutil_posix' extension 03:34:46 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:34:46 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:34:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:46 INFO - Successfully installed psutil 03:34:46 INFO - Cleaning up... 03:34:46 INFO - Return code: 0 03:34:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:46 INFO - Using env: {'DISPLAY': ':0', 03:34:46 INFO - 'HOME': '/home/cltbld', 03:34:46 INFO - 'LANG': 'en_US.UTF-8', 03:34:46 INFO - 'LANGUAGE': 'en_US:en', 03:34:46 INFO - 'LOGNAME': 'cltbld', 03:34:46 INFO - 'MAIL': '/var/mail/cltbld', 03:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:46 INFO - 'MOZ_NO_REMOTE': '1', 03:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:46 INFO - 'NO_EM_RESTART': '1', 03:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:46 INFO - 'PWD': '/builds/slave/test', 03:34:46 INFO - 'SHELL': '/bin/bash', 03:34:46 INFO - 'SHLVL': '1', 03:34:46 INFO - 'TERM': 'linux', 03:34:46 INFO - 'TMOUT': '86400', 03:34:46 INFO - 'USER': 'cltbld', 03:34:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:46 INFO - '_': '/tools/buildbot/bin/python'} 03:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:46 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:34:46 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:34:46 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:34:46 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:34:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:48 INFO - Installing collected packages: mozsystemmonitor 03:34:48 INFO - Running setup.py install for mozsystemmonitor 03:34:48 INFO - Successfully installed mozsystemmonitor 03:34:48 INFO - Cleaning up... 03:34:48 INFO - Return code: 0 03:34:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:48 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:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:48 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:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:48 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:48 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:34:48 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:34:48 INFO - Using env: {'DISPLAY': ':0', 03:34:48 INFO - 'HOME': '/home/cltbld', 03:34:48 INFO - 'LANG': 'en_US.UTF-8', 03:34:48 INFO - 'LANGUAGE': 'en_US:en', 03:34:48 INFO - 'LOGNAME': 'cltbld', 03:34:48 INFO - 'MAIL': '/var/mail/cltbld', 03:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:48 INFO - 'MOZ_NO_REMOTE': '1', 03:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:48 INFO - 'NO_EM_RESTART': '1', 03:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:48 INFO - 'PWD': '/builds/slave/test', 03:34:48 INFO - 'SHELL': '/bin/bash', 03:34:48 INFO - 'SHLVL': '1', 03:34:48 INFO - 'TERM': 'linux', 03:34:48 INFO - 'TMOUT': '86400', 03:34:48 INFO - 'USER': 'cltbld', 03:34:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:48 INFO - '_': '/tools/buildbot/bin/python'} 03:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:48 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:49 INFO - warning: no files found matching '*.txt' 03:34:49 INFO - no previously-included directories found matching 'build' 03:34:49 INFO - no previously-included directories found matching 'dist' 03:34:49 INFO - no previously-included directories found matching '.git*' 03:34:49 INFO - Installing collected packages: jsonschema, functools32 03:34:49 INFO - Running setup.py install for functools32 03:34:49 INFO - warning: no files found matching '*.txt' 03:34:49 INFO - no previously-included directories found matching 'build' 03:34:49 INFO - no previously-included directories found matching 'dist' 03:34:49 INFO - no previously-included directories found matching '.git*' 03:34:49 INFO - Successfully installed jsonschema functools32 03:34:49 INFO - Cleaning up... 03:34:49 INFO - Return code: 0 03:34:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:49 INFO - Using env: {'DISPLAY': ':0', 03:34:49 INFO - 'HOME': '/home/cltbld', 03:34:49 INFO - 'LANG': 'en_US.UTF-8', 03:34:49 INFO - 'LANGUAGE': 'en_US:en', 03:34:49 INFO - 'LOGNAME': 'cltbld', 03:34:49 INFO - 'MAIL': '/var/mail/cltbld', 03:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:49 INFO - 'MOZ_NO_REMOTE': '1', 03:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:49 INFO - 'NO_EM_RESTART': '1', 03:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:49 INFO - 'PWD': '/builds/slave/test', 03:34:49 INFO - 'SHELL': '/bin/bash', 03:34:49 INFO - 'SHLVL': '1', 03:34:49 INFO - 'TERM': 'linux', 03:34:49 INFO - 'TMOUT': '86400', 03:34:49 INFO - 'USER': 'cltbld', 03:34:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:49 INFO - '_': '/tools/buildbot/bin/python'} 03:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:50 INFO - Cleaning up... 03:34:50 INFO - Return code: 0 03:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:50 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:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:50 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:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:50 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:50 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:34:50 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:34:50 INFO - Using env: {'DISPLAY': ':0', 03:34:50 INFO - 'HOME': '/home/cltbld', 03:34:50 INFO - 'LANG': 'en_US.UTF-8', 03:34:50 INFO - 'LANGUAGE': 'en_US:en', 03:34:50 INFO - 'LOGNAME': 'cltbld', 03:34:50 INFO - 'MAIL': '/var/mail/cltbld', 03:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:50 INFO - 'MOZ_NO_REMOTE': '1', 03:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:50 INFO - 'NO_EM_RESTART': '1', 03:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:50 INFO - 'PWD': '/builds/slave/test', 03:34:50 INFO - 'SHELL': '/bin/bash', 03:34:50 INFO - 'SHLVL': '1', 03:34:50 INFO - 'TERM': 'linux', 03:34:50 INFO - 'TMOUT': '86400', 03:34:50 INFO - 'USER': 'cltbld', 03:34:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:50 INFO - '_': '/tools/buildbot/bin/python'} 03:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:51 INFO - Downloading docopt-0.6.1.tar.gz 03:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:52 INFO - Running setup.py install for blobuploader 03:34:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:52 INFO - Running setup.py install for requests 03:34:52 INFO - Running setup.py install for docopt 03:34:52 INFO - Successfully installed blobuploader requests docopt 03:34:52 INFO - Cleaning up... 03:34:52 INFO - Return code: 0 03:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:52 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:52 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:34:52 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:34:52 INFO - Using env: {'DISPLAY': ':0', 03:34:52 INFO - 'HOME': '/home/cltbld', 03:34:52 INFO - 'LANG': 'en_US.UTF-8', 03:34:52 INFO - 'LANGUAGE': 'en_US:en', 03:34:52 INFO - 'LOGNAME': 'cltbld', 03:34:52 INFO - 'MAIL': '/var/mail/cltbld', 03:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:52 INFO - 'MOZ_NO_REMOTE': '1', 03:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:52 INFO - 'NO_EM_RESTART': '1', 03:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:52 INFO - 'PWD': '/builds/slave/test', 03:34:52 INFO - 'SHELL': '/bin/bash', 03:34:52 INFO - 'SHLVL': '1', 03:34:52 INFO - 'TERM': 'linux', 03:34:52 INFO - 'TMOUT': '86400', 03:34:52 INFO - 'USER': 'cltbld', 03:34:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:52 INFO - '_': '/tools/buildbot/bin/python'} 03:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:52 INFO - Running setup.py (path:/tmp/pip-1zZ4n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:52 INFO - Running setup.py (path:/tmp/pip-v1orpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:53 INFO - Running setup.py (path:/tmp/pip-Q4F3Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:53 INFO - Running setup.py (path:/tmp/pip-PteMI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:53 INFO - Running setup.py (path:/tmp/pip-4StIhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:53 INFO - Running setup.py (path:/tmp/pip-lEUpk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:53 INFO - Running setup.py (path:/tmp/pip-hQfbFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:53 INFO - Running setup.py (path:/tmp/pip-89NOcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:53 INFO - Running setup.py (path:/tmp/pip-qNzeup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:53 INFO - Running setup.py (path:/tmp/pip-d58Koc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:53 INFO - Running setup.py (path:/tmp/pip-UI_usv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:53 INFO - Running setup.py (path:/tmp/pip-ozfDVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:53 INFO - Running setup.py (path:/tmp/pip-O4iZC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:53 INFO - Running setup.py (path:/tmp/pip-H0dej0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:53 INFO - Running setup.py (path:/tmp/pip-6bnDCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:53 INFO - Running setup.py (path:/tmp/pip-fh2WuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:54 INFO - Running setup.py (path:/tmp/pip-5twR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:54 INFO - Running setup.py install for manifestparser 03:34:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Running setup.py install for mozcrash 03:34:54 INFO - Running setup.py install for mozdebug 03:34:54 INFO - Running setup.py install for mozdevice 03:34:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Running setup.py install for mozfile 03:34:54 INFO - Running setup.py install for mozhttpd 03:34:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Running setup.py install for mozinfo 03:34:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Running setup.py install for mozInstall 03:34:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:54 INFO - Running setup.py install for mozleak 03:34:54 INFO - Running setup.py install for mozlog 03:34:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Running setup.py install for moznetwork 03:34:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Running setup.py install for mozprocess 03:34:55 INFO - Running setup.py install for mozprofile 03:34:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Running setup.py install for mozrunner 03:34:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Running setup.py install for mozscreenshot 03:34:55 INFO - Running setup.py install for moztest 03:34:55 INFO - Running setup.py install for mozversion 03:34:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:55 INFO - Cleaning up... 03:34:55 INFO - Return code: 0 03:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:55 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:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:55 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:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:55 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:55 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:34:55 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:34:55 INFO - Using env: {'DISPLAY': ':0', 03:34:55 INFO - 'HOME': '/home/cltbld', 03:34:55 INFO - 'LANG': 'en_US.UTF-8', 03:34:55 INFO - 'LANGUAGE': 'en_US:en', 03:34:55 INFO - 'LOGNAME': 'cltbld', 03:34:55 INFO - 'MAIL': '/var/mail/cltbld', 03:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:55 INFO - 'MOZ_NO_REMOTE': '1', 03:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:55 INFO - 'NO_EM_RESTART': '1', 03:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:55 INFO - 'PWD': '/builds/slave/test', 03:34:55 INFO - 'SHELL': '/bin/bash', 03:34:55 INFO - 'SHLVL': '1', 03:34:55 INFO - 'TERM': 'linux', 03:34:55 INFO - 'TMOUT': '86400', 03:34:55 INFO - 'USER': 'cltbld', 03:34:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:55 INFO - '_': '/tools/buildbot/bin/python'} 03:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:56 INFO - Running setup.py (path:/tmp/pip-g8nZkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:56 INFO - Running setup.py (path:/tmp/pip-Re0gEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:56 INFO - Running setup.py (path:/tmp/pip-UClQkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:56 INFO - Running setup.py (path:/tmp/pip-L3uaBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:56 INFO - Running setup.py (path:/tmp/pip-FVocMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:56 INFO - Running setup.py (path:/tmp/pip-yOcNKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:56 INFO - Running setup.py (path:/tmp/pip-HT9v2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:56 INFO - Running setup.py (path:/tmp/pip-QbQZ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:56 INFO - Running setup.py (path:/tmp/pip-IlMgUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:56 INFO - Running setup.py (path:/tmp/pip-7hAqAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:56 INFO - Running setup.py (path:/tmp/pip-qQEhmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:56 INFO - Running setup.py (path:/tmp/pip-3Dn0WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:57 INFO - Running setup.py (path:/tmp/pip-Ka0Ni1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:57 INFO - Running setup.py (path:/tmp/pip-ulCOAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:57 INFO - Running setup.py (path:/tmp/pip-vvJNUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:57 INFO - Running setup.py (path:/tmp/pip-X_xm0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:57 INFO - Running setup.py (path:/tmp/pip-pNs1e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:57 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:34:57 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:34:57 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:34:57 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:34:58 INFO - Downloading blessings-1.6.tar.gz 03:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:58 INFO - Installing collected packages: blessings 03:34:58 INFO - Running setup.py install for blessings 03:34:58 INFO - Successfully installed blessings 03:34:58 INFO - Cleaning up... 03:34:58 INFO - Return code: 0 03:34:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:58 INFO - Reading from file tmpfile_stdout 03:34:58 INFO - Current package versions: 03:34:58 INFO - argparse == 1.2.1 03:34:58 INFO - blessings == 1.6 03:34:58 INFO - blobuploader == 1.2.4 03:34:58 INFO - docopt == 0.6.1 03:34:58 INFO - functools32 == 3.2.3-2 03:34:58 INFO - jsonschema == 2.5.1 03:34:58 INFO - manifestparser == 1.1 03:34:58 INFO - mozInstall == 1.13 03:34:58 INFO - mozcrash == 1.0 03:34:58 INFO - mozdebug == 0.1 03:34:58 INFO - mozdevice == 0.51 03:34:58 INFO - mozfile == 1.2 03:34:58 INFO - mozhttpd == 0.7 03:34:58 INFO - mozinfo == 0.10 03:34:58 INFO - mozleak == 0.1 03:34:58 INFO - mozlog == 3.5 03:34:58 INFO - moznetwork == 0.27 03:34:58 INFO - mozprocess == 0.25 03:34:58 INFO - mozprofile == 0.28 03:34:58 INFO - mozrunner == 6.13 03:34:58 INFO - mozscreenshot == 0.1 03:34:58 INFO - mozsystemmonitor == 0.3 03:34:58 INFO - moztest == 0.8 03:34:58 INFO - mozversion == 1.4 03:34:58 INFO - psutil == 3.1.1 03:34:58 INFO - requests == 1.2.3 03:34:58 INFO - wsgiref == 0.1.2 03:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:58 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:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:58 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:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:58 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:34:58 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:34:58 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:34:58 INFO - Using env: {'DISPLAY': ':0', 03:34:58 INFO - 'HOME': '/home/cltbld', 03:34:58 INFO - 'LANG': 'en_US.UTF-8', 03:34:58 INFO - 'LANGUAGE': 'en_US:en', 03:34:58 INFO - 'LOGNAME': 'cltbld', 03:34:58 INFO - 'MAIL': '/var/mail/cltbld', 03:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:58 INFO - 'MOZ_NO_REMOTE': '1', 03:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:58 INFO - 'NO_EM_RESTART': '1', 03:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:58 INFO - 'PWD': '/builds/slave/test', 03:34:58 INFO - 'SHELL': '/bin/bash', 03:34:58 INFO - 'SHLVL': '1', 03:34:58 INFO - 'TERM': 'linux', 03:34:58 INFO - 'TMOUT': '86400', 03:34:58 INFO - 'USER': 'cltbld', 03:34:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:58 INFO - '_': '/tools/buildbot/bin/python'} 03:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34:59 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:34:59 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:34:59 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:34:59 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:35:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:35:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:00 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:35:00 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:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:00 INFO - Installing collected packages: marionette-driver, simplejson 03:35:00 INFO - Running setup.py install for marionette-driver 03:35:00 INFO - Running setup.py install for simplejson 03:35:00 INFO - building 'simplejson._speedups' extension 03:35:00 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:35:01 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:35:01 INFO - Successfully installed marionette-driver simplejson 03:35:01 INFO - Cleaning up... 03:35:01 INFO - Return code: 0 03:35:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:01 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 0x1b2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', '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:35:01 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:35:01 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:35:01 INFO - Using env: {'DISPLAY': ':0', 03:35:01 INFO - 'HOME': '/home/cltbld', 03:35:01 INFO - 'LANG': 'en_US.UTF-8', 03:35:01 INFO - 'LANGUAGE': 'en_US:en', 03:35:01 INFO - 'LOGNAME': 'cltbld', 03:35:01 INFO - 'MAIL': '/var/mail/cltbld', 03:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:01 INFO - 'MOZ_NO_REMOTE': '1', 03:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:01 INFO - 'NO_EM_RESTART': '1', 03:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:01 INFO - 'PWD': '/builds/slave/test', 03:35:01 INFO - 'SHELL': '/bin/bash', 03:35:01 INFO - 'SHLVL': '1', 03:35:01 INFO - 'TERM': 'linux', 03:35:01 INFO - 'TMOUT': '86400', 03:35:01 INFO - 'USER': 'cltbld', 03:35:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:01 INFO - '_': '/tools/buildbot/bin/python'} 03:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:01 INFO - Cleaning up... 03:35:01 INFO - Return code: 0 03:35:01 INFO - Running post-action listener: _resource_record_post_action 03:35:01 INFO - Running post-action listener: _start_resource_monitoring 03:35:01 INFO - Starting resource monitoring. 03:35:01 INFO - [mozharness: 2017-07-29 10:35:01.958000Z] Finished create-virtualenv step (success) 03:35:01 INFO - [mozharness: 2017-07-29 10:35:01.958962Z] Running install step. 03:35:01 INFO - Running pre-action listener: _resource_record_pre_action 03:35:01 INFO - Running main action method: install 03:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:02 INFO - Reading from file tmpfile_stdout 03:35:02 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:02 INFO - Reading from file tmpfile_stdout 03:35:02 INFO - Output received: 03:35:02 INFO - Usage: mozinstall [options] installer 03:35:02 INFO - Options: 03:35:02 INFO - -h, --help show this help message and exit 03:35:02 INFO - -d DEST, --destination=DEST 03:35:02 INFO - Directory to install application into. [default: 03:35:02 INFO - "/builds/slave/test"] 03:35:02 INFO - --app=APP Application being installed. [default: firefox] 03:35:02 INFO - mkdir: /builds/slave/test/build/application 03:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:20 INFO - Reading from file tmpfile_stdout 03:35:20 INFO - Output received: 03:35:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:20 INFO - Running post-action listener: _resource_record_post_action 03:35:20 INFO - [mozharness: 2017-07-29 10:35:20.293018Z] Finished install step (success) 03:35:20 INFO - [mozharness: 2017-07-29 10:35:20.293165Z] Running setup-mitmproxy step. 03:35:20 INFO - Running pre-action listener: _resource_record_pre_action 03:35:20 INFO - Running main action method: setup_mitmproxy 03:35:20 INFO - Skipping: mitmproxy is not required 03:35:20 INFO - Running post-action listener: _resource_record_post_action 03:35:20 INFO - [mozharness: 2017-07-29 10:35:20.294143Z] Finished setup-mitmproxy step (success) 03:35:20 INFO - [mozharness: 2017-07-29 10:35:20.294366Z] Running run-tests step. 03:35:20 INFO - Running pre-action listener: _resource_record_pre_action 03:35:20 INFO - Running pre-action listener: _set_gcov_prefix 03:35:20 INFO - Running main action method: run_tests 03:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:20 INFO - Python 2.7.3 03:35:20 INFO - Return code: 0 03:35:20 INFO - grabbing minidump binary from tooltool 03:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1e9beb0>, '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 0x1e9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9d240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:35:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:35:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:20 INFO - Return code: 0 03:35:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:20 INFO - ENV: RUST_BACKTRACE is now 1 03:35:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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:35:20 INFO - Using env: {'DISPLAY': ':0', 03:35:20 INFO - 'HOME': '/home/cltbld', 03:35:20 INFO - 'LANG': 'en_US.UTF-8', 03:35:20 INFO - 'LANGUAGE': 'en_US:en', 03:35:20 INFO - 'LOGNAME': 'cltbld', 03:35:20 INFO - 'MAIL': '/var/mail/cltbld', 03:35:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:20 INFO - 'MOZ_NO_REMOTE': '1', 03:35:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:20 INFO - 'NO_EM_RESTART': '1', 03:35:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:20 INFO - 'PWD': '/builds/slave/test', 03:35:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:20 INFO - 'RUST_BACKTRACE': '1', 03:35:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:20 INFO - 'SHELL': '/bin/bash', 03:35:20 INFO - 'SHLVL': '1', 03:35:20 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:20 INFO - 'TERM': 'linux', 03:35:20 INFO - 'TMOUT': '86400', 03:35:20 INFO - 'USER': 'cltbld', 03:35:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380', 03:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:20 INFO - '_': '/tools/buildbot/bin/python'} 03:35:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:35:20 INFO - mozversion application_buildid: 20170729094428 03:35:20 INFO - mozversion application_changeset: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 03:35:20 INFO - mozversion application_display_name: Nightly 03:35:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:20 INFO - mozversion application_name: Firefox 03:35:20 INFO - mozversion application_remotingname: firefox 03:35:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:20 INFO - mozversion application_vendor: Mozilla 03:35:20 INFO - mozversion application_version: 56.0a1 03:35:20 INFO - mozversion platform_buildid: 20170729094428 03:35:20 INFO - mozversion platform_changeset: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 03:35:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:20 INFO - mozversion platform_version: 56.0a1 03:35:20 INFO - using testdate: 1501324520 03:35:20 INFO - actual date: 1501324520 03:35:20 INFO - starting webserver on 'localhost:40081' 03:35:20 INFO - SUITE-START | Running 2 tests 03:35:20 INFO - TEST-START | dromaeo_css 03:35:20 INFO - Initialising browser for dromaeo_css test... 03:35:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40081/getInfo.html -profile /tmp/tmpVieijW/profile 03:35:20 INFO - TEST-INFO | started process 3360 (/builds/slave/test/build/application/firefox/firefox http://localhost:40081/getInfo.html) 03:35:29 INFO - TEST-INFO | 3360: exit 0 03:35:29 INFO - Browser initialized. 03:35:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:29 INFO - TEST-INFO | started process 3586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVieijW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:30 INFO - PID 3586 | 03:35:30 INFO - PID 3586 | (/builds/slave/test/build/application/firefox/firefox:3640): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:30 INFO - PID 3586 | 03:35:40 INFO - PID 3586 | RSS: Main: 173576192 03:35:40 INFO - PID 3586 | 03:38:41 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40081/tests/dromaeo/cssquery-ext.html) 03:38:42 INFO - PID 3586 | RSS: Main: 174735360 03:38:42 INFO - PID 3586 | 03:41:44 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-ext.html (next: http://localhost:40081/tests/dromaeo/cssquery-jquery.html) 03:41:44 INFO - PID 3586 | RSS: Main: 172634112 03:41:44 INFO - PID 3586 | 03:44:46 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40081/tests/dromaeo/cssquery-mootools.html) 03:44:47 INFO - PID 3586 | RSS: Main: 174592000 03:44:47 INFO - PID 3586 | 03:47:49 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40081/tests/dromaeo/cssquery-prototype.html) 03:47:49 INFO - PID 3586 | RSS: Main: 171270144 03:47:49 INFO - PID 3586 | 03:50:53 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40081/tests/dromaeo/cssquery-yui.html) 03:50:54 INFO - PID 3586 | RSS: Main: 172929024 03:50:54 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | Cycle 1(1): loaded http://localhost:40081/tests/dromaeo/cssquery-yui.html (next: http://localhost:40081/tests/dromaeo/cssquery-dojo.html) 03:53:56 INFO - PID 3586 | RSS: Main: 176881664 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | __start_tp_report 03:53:56 INFO - PID 3586 | _x_x_mozilla_page_load 03:53:56 INFO - PID 3586 | _x_x_mozilla_page_load_details 03:53:56 INFO - PID 3586 | |i|pagename|runs| 03:53:56 INFO - PID 3586 | |0;dojo.html;3118.2827949571597;3144.8113113213194;3157.2580443595753;3190.34597907429;3193.058047875877;6232.189815324002;6233.127362169294;6258.749650014;6268.404501572355;6281.1520444739945;6058.515318774498;6148.35442278561;6183.567150299481;6185.690715464231;6214.502839772818;5668.291463567064;5713.685747283897;5720.542356611482;5734.541236701054;5765.962126817171;5655.7172141392975;5718;5799.507041901444;5812.941870581303;5823.359430462646;5715.0855863061915;5737.39757325479;5768.596198266123;5771;5847.883042339151;5484.561235101182;5609.719514024323;5723.627964182315;5754.251947246852;5768.567357448187;5146.716930568818;5625.578081643893;5637.3517045539875;5638.4925356718095;5655.802046928337;6024.457798798129;6095.08573713942;6190.690465476753;6214.844628884269;6220.533459990474;6423.903641445382;6507.186601674791;6578;6680.1983761948395;6695.096162018114;6679.198496180489;6731.259561448237;6739.090222819906;6741.157355330583;6744.6627668616375;6167.845803854894;6220.129181914535;6230.376962303733;6231.813045608594;6233.906491402633;6865.622390768555;6871;6876.140482439695;6876.140482439695;6878.69045892926;6434.903476447857;6556.8360790980605;6563.7702680405955;6565.048068030204;6569.605823650596;6721.596704197764;6764.526483146133;6766.69549870257;6790.32096790317;6807.774600571945;6640.435562977104;6641.103451034145;6655.700493477805;6692.063111164441;6765.695543700447;6530.706118224692;6681.164854393201;6711.899321510181;6780.423663988518;6801.727930882709;5428.4842939920645;5468.207109969032;5470.124780035176;5470.617056805985;5484.012877682056;4634.83778067766;4635.884102897455;4643.303504474288;4719.646026548023;4766.475687674353;5722.942770572325;5774.855628609318;5805.245318108618;5810.41895810424;5826.475617194473;6666.933330666729;6667.399934005963;6737.9663101685155;6751.493637977073;6753.527253092237;5670.347909990322;5704.201411802351;5803.767849285981;5815.73829177688;5834.679092649945;5952.5833191676165;5957.046872500466;5964.7315870785915;5965.28416590012;5966.820995370146;6487.448566871774;6509.056186852879;6543.901841472381;6580.309067547934;6580.769673061515;6683.365080317362;6722.260551339251;6728.629925354153;6795.048693182859;6836.418904393182;6346.587471814318;6422.389872962061;6506.25178104524;6560.901586476302;6562.146920900253;6632.071509988702;6638.435732962752;6643.933560664332;6645.800625981228;6645.833854153685;6718.428933540704;6825.419839313516;6833.555818871758;6842.486813488908;6842.692078856364;6593.406593406617;6593.736250550116;6594.406503414716;6594.90107648376;6595.538312318284;6249.9062514063235;6606.47148228131;6607.669616519251;6614.70233839488;6643.202815662152;6339.017452294902;6412.9679351602945;6430.871382572229;6466.676666166579;6563.1796025496815;6553.344665533408;6565.179352580927;6581;6612.966935165486;6676.432503237279;6243.313235544178;6329.145565348803;6337.144485494399;6341.8731625368155;6421.678916054272 03:53:56 INFO - PID 3586 | |1;ext.html;806.3428305930667;838.7651457591875;868.4919322196515;876.0801158783275;1174.3012907320142;30625.693743062562;31182.84408577957;40914.7954260229;42033.369499457534;42040.15919681604;41802.37296440556;42348.78825605875;42395.788021059925;42471;42494.787526062326;7416.703331866745;7782.64978075988;8120.187981201862;8129.349652027853;8133.227343402367;7824;7944.205579442068;7962.323202527792;7991.041075071;8004.759857204293;7964.084130325029;8004.399670024772;8016.398770092237;8020.879686804703;8021.278084972351;7974.444983228273;7974.760757177294;7993.360531157494;7995.920040799605;8002.8799568006525;7869;7958.204179582053;7962.681492740284;7966.163552826985;7966.482178658426;37527.249455010744;37741.622583774086;37825;37857.621423785684;37891;3478.7912725236565;3493.807840568768;3525.383057964846;3528.858845646171;3530.9823450882836;30947;31041.37917241665;31049.53425698594;31066;31097.689023109706;4765;4816.277558366238;4819.108464933998;4821.083994041156;4851.078295123915;187957;188005;188647;190208.0489597557;190412;47164;47258.29112563314;47344.28983565249;47365.28952065722;47568;49162;49382.25926611032;49436.75281623569;49438.25842612363;49444.75277623661;13251;13561.457541698419;15480.845191548166;15750.9212453937;15801.209939502978;11117.110631149488;11835.11236657254;12212.755744885053;12262.080343974238;12271.69320766988;13549.796753048711;13592.524261650795;13716.725665486634;13720.245386503839;13916.02587818843;5498.5876059295715;5664.8867022659315;5687.914681279784;5691.573132015115;5719.628224165416;980.547365088171;981.4356744871585;982.6069572171189;1020.3571749797728;1025.7179275699243;22232.333030009126;22288.442788930406;22289.554208916055;22387;22885.199018034287;1073.8603981482356;1096.5568311665459;1099.796537640539;1101.3777215873006;1110.8944650258213;11763.647090587296;11782.057435405148;11891.70270743221;12006.039516838631;12034.81947770784;218183;219892;220567;221104;221335;50104.749476252386;50596;50605.24092138621;50858;51015.74492127515;1449.2608769527617;1459.1318165691184;1496.5211132437732;1498.887583431247;1514;21569.137234510443;21802.672959905933;21909.452263693536;22085.779142208372;22193.556128877655;36101;36281.45577816282;36283;36284.81857590695;36332.27335453223;180172;180369;180833;180841;180889;32263.677363226067;34243.65756342404;35173.824130879184;35282.82358588191;35394;42896.78551607222;44766.77616611896;45017.32474012958;45213.321800172365;45276.77361613171;30585.847070764503;31086;31608.525872112397;31775.841120795172;31957.520637189995;31476.842615786776;31782;31949.20126996844;32122;32215.194620134684;36014.8199259002;36205.27589448249;36210.8189459051;36379;36437.63562364342;29919;30633.54049689301;32025.839870800497;32477.512837306986;32621.673783261864;23450.53098938046;23522.64716029227;24008.51982960296;24211.757882421654;24517.264482065566 03:53:56 INFO - PID 3586 | |2;jquery.html;563.3830955104161;567.9346875109363;568.4457653787557;582.0392230868938;590.3565114025713;21466.677999829997;22255.22106726265;22255.888720556373;22279;22323.553528929413;24926.62610060846;25692;25875.74124258757;27010;27025.1892443227;6301.338359472258;6471.352864713538;6480.902786458183;6485.124508191405;6495.707693153796;6436.549441539094;6439.484841212692;6484.935150648504;6508.414242718154;6512.6092434454085;5819.592628516006;6372;6393.712282947278;6399.200099987502;6417.647029413381;6370.426661600455;6377.96811015942;6413.486921046305;6434.485241180718;6437.678116094224;5889.4993925515955;5949.732262048218;5949.9702501487645;5959.344472108065;5962.747822957184;27510.587341189897;28112.578311325346;28389.72882169442;28773;28814.135575932756;1805.873588848781;1841.171472837215;1842.4104286628285;1845.4371416717895;1845.713914343279;19010.904945475184;19344.70982935257;19497.610047798964;19502.80497195024;19619.313324033592;2233.1960494222067;2294.128231272123;2306.7923886850094;2323.5585238804574;2325.5581439526436;134148.32925835406;137539.31230343884;138056;138349;138446;14496.492622758153;14557.708845823025;14655.680988711067;14698.33857476416;14889.404423823142;23446.06215751351;23462.061517539107;23513.412164695677;23527.17654882071;23540.176093836635;9891.752706182258;10072.647457339104;10145.28982971185;10201.795964080826;10328.328658637314;9429.481378524248;9474.857877131848;9480.668176613923;9578.616855325849;9720.07659272368;8714.389992700577;8935;9135.937811441154;9403.106704863027;9422.434653920787;2691.3406215477335;2762.811990843956;2764.543850264684;2766.169154228856;2885.422915416925;920.3741455810114;932.7201839448138;933.9066093390607;974.9902500974899;975.6292608808608;18366.449006529827;19001.809981900282;19063.428097157106;19833.702494462595;22747;975.6341371985505;999.9850002249972;1003.4882210072915;1030.8093002794358;1033.7622346860264;10772.353658780497;11123.332600044023;11166.274192177483;11270.267432616854;11349.452614011754;495639;500516;503742;519117;523209;111901;114329;115047.42476287566;115435.42282288535;115514;1224.6203676860202;1264.2856785915928;1282.044876566945;1290.4451086033096;1290.806379043151;19151.904240478707;20683.58632827365;20924.58150837005;21014.474638133557;21080.367588972356;53497.73251133719;54139;54930.725346373016;57002;57070;70416.64791676009;70479;71123.64438177776;71484.64257678678;71601.28398715946;12109.69725756863;14398.856011439751;14574.708505829612;14577.344019518934;14745.894057945912;18690;18934.905325473836;22270.888645556668;23080;23279.76720232776;17610.647787044443;18184.545386364916;18340.724889126406;18649.254029838656;19515.12181951844;16264;16715.74926376081;16974.830251697324;17284;17571.297148113932;19920.203191872162;19994.20023199056;20069;20305.59388812245;20313.187472500933;13954.441822327399;14530.128192308495;14706.705865882837;14796.48212312564;14832.703345933236;18666.440006799818;18883.150258238686;18889.90555047216;18890.149943252312;18927.432177034712 03:53:56 INFO - PID 3586 | |3;mootools.html;1350.878420942115;1377.786443101319;1387.805707200992;1406.4374250299873;1412.2091628687936;13544.864551354496;14146.151230926152;14221.21783301918;14222.28888555572;14243.643908902282;13573.796393054088;14451.421943122288;14503.129812211275;14507.27463626817;14550.981431299813;2736.7400096990755;2771.514984877648;2780.4995100881833;2785.4150628368066;2794.6786119596304;2601.9722209727147;2668.1995401379604;2679.7990150738674;2714.7556719895206;2730.3856632257684;2746;2771.9168424947184;2785.6796468406087;2789.428167225714;2793.329600895791;2626.3565426470445;2662.986685066572;2673.9465210695776;2683.771879390264;2714.24001279642;2627.1199148285154;2647.3646324882084;2651.7536757723838;2655.1768951624863;2675.023616380027;13594.93202533991;13709.725805483935;13738.65653358664;13876.444942202299;13919.373628186755;7470.140933792629;7768.922310776877;7787.29914307715;7790.104138024143;7795.610219489003;4873.975630121862;5060.569851562622;5074.99537682617;5177.171652535576;5189.273501709764;1802.6034272460038;1827.798942116366;1850.5096149520389;1883.0867029490687;1896.5163883209832;22500.212492562845;22679.546409071725;22698.54602907949;22704.54590908189;22727.659085113737;6282.921368529388;6485.935140648533;6572.769953051716;6676.6327851967635;6686.063951046857;15688.137152456724;15710.685786284439;15749.291281892343;15755.68488630221;15779.684406312039;7464.1416237132335;7656.770296891103;7692.499987500794;7695.653695583712;7696.230376962371;6899.137607799025;6911.6544172791155;7108.218096009435;7140.285971402818;7179.856402871913;4980.252962055721;5108.6168537359845;5119.539241468211;5130;5163.638545301793;1375.2917247617286;1424.9002569820013;1496.8503149685162;1511.093343993617;1539.5535294764618;798.9280964713204;818.1123481023037;840.1976112812249;846.949183049019;857.7212405968086;7422.777316680508;7634.160242373335;7661.348785353307;7666.8849967250535;7799.220077992155;935.1350001248818;935.2144198872843;959.5654496527736;967.970960871175;970.8349580571179;4667.206574882278;4690.507496712864;4723.220668589713;4858.416989961227;5024.422191447957;17976.550586235448;18532.907335463235;18544.629107418044;18618.16218270154;18659.626807463774;17356.82643173552;18247.27010919575;18778.436646900616;18784.248630054917;18791.530211744543;10056.949715251378;10133.695989120339;10160.288779785493;10274.126699230648;10277.126444252173;7144.714211431485;7746.845063098819;7876.133625301098;7925.801854953672;7942.6028698566;15616.375344986527;16160.11119388445;16247.268872900984;16391.83608163903;16458.259378327766;15849.890507664353;16320.67358652844;16338.346466141222;16609;16994.235259413108;11379.943100284776;11585.073194144617;11617.825732613848;11621.24461909973;11645.59240426581;12746.171498852545;12779.744405112031;12968.481260749464;13205.273709946045;13225.140365876186;9393.953030234805;9865.506724663881;10290.639827605997;10291.176705863663;10375.740606484596;9897;10326.896731032894;10354.792904142025;10514.526846291783;10672;8809;8910.599023044108;8924.553772311228;8938;8941.284697224077;6625.4699624029;6646.567973081735;6685;6727.192736871607;6811.659417029228;6431.260405053292;6446.67766611677;6472.773452929125;6575.80272591823;6587.934120658732 03:53:56 INFO - PID 3586 | |4;prototype.html;500.2284933687784;503.67282211373043;513.8175947538623;519.695977852956;527.2539356810114;6140.907886381708;6198.194234749481;6214.378562143784;6216.1918950536365;6221.968890155548;5866.823995280149;5934.87237424889;5993.760249590022;6079;6094.7505761318935;4837;4851.587615052725;4857;4905.779239934193;4910.410750709911;4897.6081913447015;4905.779239934212;4914.508549145093;4922.655414121013;4942.382202224722;4744.884952036269;4897.755112244374;4907.926381104268;4913.582345500618;4943.480934501879;4881.048195601859;4899.1426500362295;4899.289603007562;4959.504049595048;4985.033904826622;4385.649148068147;4392.121575684876;4402.713823601455;4423.358613001129;4437.5784300491405;5891.882162356772;5956.702164891782;5965.850853728648;5973.790917317917;5992;5649.9152512711935;5661;5674.233978412903;5683.2895888014;5699.886002279973;6276.717547710364;6342.143810585558;6351.904721429182;6366.87266254677;6430.807075787734;4751.239801631757;4831.444383895861;4832.251001094836;4864.100141473838;4873.585745211662;6833.487488438387;6916.23921368649;6921.307869213088;6923.238443771181;6936.93063069373;4929.704217746875;4944.554990050912;4948.579370753454;5002.299678045077;5004.42272229802;4979.676321039121;4983.426905905795;4983.700977941335;5000.774965126578;5047.384836852246;5630.493255607015;5638.633488823213;5648.661080335193;5664.063475884221;5688.77244910199;6539.332470220063;6599.901001484982;6618.801435956929;6646.26891041985;6661.2006559213205;1648.3571407151221;1699.1674079700858;1700.200905574378;1756.5872020075271;1774.308019872251;1162.39555431177;1209.6492017314881;1212.090931801149;1224.9020078393708;1236.1594116001206;5594.580406469531;5639.379668236491;5640.520555752807;5682.318121825408;5712;6483;6505.837354066091;6591.00109450199;6614.272430032693;6619.470442364599;5524;5581.10702287632;5646.096624540136;5657.405972372924;5673.007223735913;3454.809985450824;3491.546099007164;3512.332656795201;3522.4011917973494;3526.536487357769;6232.25212974446;6280.528960327993;6326.481644405309;6373.3945275198785;6374.394432528902;6567.9671601641685;6590;6598.074145883192;6611.371919667624;6773.695183716744;6224.782132625336;6235.158253635792;6236.220472440945;6284.24589049317;6388.616682999035;6374.872502550016;6453.419192272718;6462.256840463407;6475.287718351072;6496.155499784998;6466.159399278064;6475.514336424882;6494.220693516808;6505.479561634963;6573.737050517926;6282.717277722605;6286.277078136073;6318.778842740482;6320.5259605528845;6331.303556608861;4933.827316043921;4944.826931057396;4963.677360971526;4975.527324904128;4997.400311962588;6594.439472644879;6594.934050659432;6602.20773507163;6633;6665.66671666405;6245.594036387621;6339.3343698912795;6377.840553986002;6388.93611063902;6447.6453795041725;6307.873842523216;6340.714667839866;6357.682115894094;6413.679316034273;6427.453666438218;5814.970925145347;6314.747410103544;6365.427111559982;6386.552941294065;6411.230652321565;6492.805215843532;6526.706298216497;6536.444402225864;6545.607263564201;6621.602703837592;6291.748330066746;6296.968515157395;6345.746170153142;6353.4599559038;6389.233292004989 03:53:56 INFO - PID 3586 | |5;yui.html;910.3627460777453;923.335198656967;924.4591913730467;932.1284598900033;949.7198326493685;18567.535811604717;19223.615527689457;19321.806781932177;19326.710099348522;22034.33896983093;20672.68990965133;20857.165713371483;21596;21648.783512164875;21832.8908355458;1024.8462730590416;1054.7046826888484;1055.9102476289524;1056.033729137838;1056.287006270768;1049.8110340138771;1052.5158427123533;1053.336398069219;1053.852460655505;1054.8154073037226;1042.6194439029737;1093.5079214353573;1099.5107177306102;1099.587654629514;1100.0374672161859;1094.819354806456;1097.358045543358;1097.4238524774516;1097.4786976186329;1097.6103483263487;797.6051854332143;799.2606838674203;799.856025915335;800.2397722163968;800.3117319105622;18530;19379.321723739602;19529.902350488297;19553.02234888264;19821;20587.897060514602;20767;21182.470438239012;21275.361739147695;21303.68044479334;15898.364065437485;16048.919755401148;16201.918990404973;16251.431199907947;16307.755383669255;3575.5530558680166;3578.427451607756;3584.6415358464205;3604.5494313210847;3618.203995121069;120254;122511.38744306221;123346.38326808308;123837;127903.36048319699;16214.10822404779;16459.58851028734;16553.25510352037;16584.917075414545;16617;28589.71410285912;30560.541591875695;30582.847085764875;30588.847055765025;30612.846935765625;7684.231576842271;7792.766217013499;7801.414893882981;7805.80485487856;7827.84344313122;3820.426935959573;3916.9608303917166;3934.6852251819787;3953.7034722395933;3956.9604303957167;5086.92369614456;5119.87200319995;5143.151380022255;5190.740462976836;5225.111731005738;940.4122423485321;956.4404823178519;975.3124047546463;976.7851072763981;977.0766625538797;657.1260223902199;673.4072454715806;678.3792829560897;700.6356694518822;710.7015053677468;11406.258593191416;11614;12045.578404755792;12140.392980350947;12162.75674486523;662.4733336997002;688.50771698236;691.0912150522047;707.6037419045351;712.2023333866103;5157.767900444489;6208.0998255253635;6327.715252813635;6436.806895793134;6457.3865482779065;100228;100257.49871250597;101683.4915825431;107825;108108;82916.58541707252;90028.5498572503;90289;90497;93308.53345733363;76715.61642191753;83062.58468707617;83953;85547.71678424704;85737.14262857416;12212.816807747713;12392;12575.931045861204;12583;13161.947044236247;36742.26515469622;37474.437883432314;37569.62430375771;37605.05987350338;37639.81180094082;62341.37658623356;62818.08417146727;66125.33874661192;67550.3244967544;68182.3181768176;19075.618487630447;19536.60926781428;19591.216351345785;19863.404097876508;20551.177952881717;19188.273055425077;19921.60156796885;20288.492787680425;20465;20467.385978420672;19778.208871644973;19930.30243941455;20187.79812201859;20420.591588168452;20602.79397206069;20166.899165504077;20531.897340513202;20976.37070887876;21214.46963825917;21533.784662153805;19789.406317810488;19829.20683172657;20222.090005949474;20406.28577999763;20482.283120090724;12750.808737868754;13110.934445327712;13532.526361577298;13777.724445511234;13959.022868399115;14191.716165676422;14680.313519535495;15116.848831511545;15257;15476.993995390263 03:53:56 INFO - PID 3586 | __end_tp_report 03:53:56 INFO - PID 3586 | __start_cc_report 03:53:56 INFO - PID 3586 | _x_x_mozilla_cycle_collect,359 03:53:56 INFO - PID 3586 | __end_cc_report 03:53:56 INFO - PID 3586 | __startTimestamp1501325636511__endTimestamp 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | ------- Summary: start ------- 03:53:56 INFO - PID 3586 | Number of tests: 6 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#0] dojo.html Cycles:165 Average:6163.04 Median:6412.97 stddev:732.14 (11.4%) stddev-sans-first:694.33 03:53:56 INFO - PID 3586 | Values: 3118.3 3144.8 3157.3 3190.3 3193.1 6232.2 6233.1 6258.7 6268.4 6281.2 6058.5 6148.4 6183.6 6185.7 6214.5 5668.3 5713.7 5720.5 5734.5 5766.0 5655.7 5718.0 5799.5 5812.9 5823.4 5715.1 5737.4 5768.6 5771.0 5847.9 5484.6 5609.7 5723.6 5754.3 5768.6 5146.7 5625.6 5637.4 5638.5 5655.8 6024.5 6095.1 6190.7 6214.8 6220.5 6423.9 6507.2 6578.0 6680.2 6695.1 6679.2 6731.3 6739.1 6741.2 6744.7 6167.8 6220.1 6230.4 6231.8 6233.9 6865.6 6871.0 6876.1 6876.1 6878.7 6434.9 6556.8 6563.8 6565.0 6569.6 6721.6 6764.5 6766.7 6790.3 6807.8 6640.4 6641.1 6655.7 6692.1 6765.7 6530.7 6681.2 6711.9 6780.4 6801.7 5428.5 5468.2 5470.1 5470.6 5484.0 4634.8 4635.9 4643.3 4719.6 4766.5 5722.9 5774.9 5805.2 5810.4 5826.5 6666.9 6667.4 6738.0 6751.5 6753.5 5670.3 5704.2 5803.8 5815.7 5834.7 5952.6 5957.0 5964.7 5965.3 5966.8 6487.4 6509.1 6543.9 6580.3 6580.8 6683.4 6722.3 6728.6 6795.0 6836.4 6346.6 6422.4 6506.3 6560.9 6562.1 6632.1 6638.4 6643.9 6645.8 6645.8 6718.4 6825.4 6833.6 6842.5 6842.7 6593.4 6593.7 6594.4 6594.9 6595.5 6249.9 6606.5 6607.7 6614.7 6643.2 6339.0 6413.0 6430.9 6466.7 6563.2 6553.3 6565.2 6581.0 6613.0 6676.4 6243.3 6329.1 6337.1 6341.9 6421.7 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#1] ext.html Cycles:180 Average:36416.81 Median:3527.12 stddev:51081.05 (1448.2%) stddev-sans-first:51154.36 03:53:56 INFO - PID 3586 | Values: 806.3 838.8 868.5 876.1 1174.3 30625.7 31182.8 40914.8 42033.4 42040.2 41802.4 42348.8 42395.8 42471.0 42494.8 7416.7 7782.6 8120.2 8129.3 8133.2 7824.0 7944.2 7962.3 7991.0 8004.8 7964.1 8004.4 8016.4 8020.9 8021.3 7974.4 7974.8 7993.4 7995.9 8002.9 7869.0 7958.2 7962.7 7966.2 7966.5 37527.2 37741.6 37825.0 37857.6 37891.0 3478.8 3493.8 3525.4 3528.9 3531.0 30947.0 31041.4 31049.5 31066.0 31097.7 4765.0 4816.3 4819.1 4821.1 4851.1 187957.0 188005.0 188647.0 190208.0 190412.0 47164.0 47258.3 47344.3 47365.3 47568.0 49162.0 49382.3 49436.8 49438.3 49444.8 13251.0 13561.5 15480.8 15750.9 15801.2 11117.1 11835.1 12212.8 12262.1 12271.7 13549.8 13592.5 13716.7 13720.2 13916.0 5498.6 5664.9 5687.9 5691.6 5719.6 980.5 981.4 982.6 1020.4 1025.7 22232.3 22288.4 22289.6 22387.0 22885.2 1073.9 1096.6 1099.8 1101.4 1110.9 11763.6 11782.1 11891.7 12006.0 12034.8 218183.0 219892.0 220567.0 221104.0 221335.0 50104.7 50596.0 50605.2 50858.0 51015.7 1449.3 1459.1 1496.5 1498.9 1514.0 21569.1 21802.7 21909.5 22085.8 22193.6 36101.0 36281.5 36283.0 36284.8 36332.3 180172.0 180369.0 180833.0 180841.0 180889.0 32263.7 34243.7 35173.8 35282.8 35394.0 42896.8 44766.8 45017.3 45213.3 45276.8 30585.8 31086.0 31608.5 31775.8 31957.5 31476.8 31782.0 31949.2 32122.0 32215.2 36014.8 36205.3 36210.8 36379.0 36437.6 29919.0 30633.5 32025.8 32477.5 32621.7 23450.5 23522.6 24008.5 24211.8 24517.3 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#2] jquery.html Cycles:180 Average:35208.02 Median:12520.56 stddev:85365.06 (681.8%) stddev-sans-first:85564.90 03:53:56 INFO - PID 3586 | Values: 563.4 567.9 568.4 582.0 590.4 21466.7 22255.2 22255.9 22279.0 22323.6 24926.6 25692.0 25875.7 27010.0 27025.2 6301.3 6471.4 6480.9 6485.1 6495.7 6436.5 6439.5 6484.9 6508.4 6512.6 5819.6 6372.0 6393.7 6399.2 6417.6 6370.4 6378.0 6413.5 6434.5 6437.7 5889.5 5949.7 5950.0 5959.3 5962.7 27510.6 28112.6 28389.7 28773.0 28814.1 1805.9 1841.2 1842.4 1845.4 1845.7 19010.9 19344.7 19497.6 19502.8 19619.3 2233.2 2294.1 2306.8 2323.6 2325.6 134148.3 137539.3 138056.0 138349.0 138446.0 14496.5 14557.7 14655.7 14698.3 14889.4 23446.1 23462.1 23513.4 23527.2 23540.2 9891.8 10072.6 10145.3 10201.8 10328.3 9429.5 9474.9 9480.7 9578.6 9720.1 8714.4 8935.0 9135.9 9403.1 9422.4 2691.3 2762.8 2764.5 2766.2 2885.4 920.4 932.7 933.9 975.0 975.6 18366.4 19001.8 19063.4 19833.7 22747.0 975.6 1000.0 1003.5 1030.8 1033.8 10772.4 11123.3 11166.3 11270.3 11349.5 495639.0 500516.0 503742.0 519117.0 523209.0 111901.0 114329.0 115047.4 115435.4 115514.0 1224.6 1264.3 1282.0 1290.4 1290.8 19151.9 20683.6 20924.6 21014.5 21080.4 53497.7 54139.0 54930.7 57002.0 57070.0 70416.6 70479.0 71123.6 71484.6 71601.3 12109.7 14398.9 14574.7 14577.3 14745.9 18690.0 18934.9 22270.9 23080.0 23279.8 17610.6 18184.5 18340.7 18649.3 19515.1 16264.0 16715.7 16974.8 17284.0 17571.3 19920.2 19994.2 20069.0 20305.6 20313.2 13954.4 14530.1 14706.7 14796.5 14832.7 18666.4 18883.2 18889.9 18890.1 18927.4 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#3] mootools.html Cycles:180 Average:8516.29 Median:2674.49 stddev:5752.21 (215.1%) stddev-sans-first:5743.15 03:53:56 INFO - PID 3586 | Values: 1350.9 1377.8 1387.8 1406.4 1412.2 13544.9 14146.2 14221.2 14222.3 14243.6 13573.8 14451.4 14503.1 14507.3 14551.0 2736.7 2771.5 2780.5 2785.4 2794.7 2602.0 2668.2 2679.8 2714.8 2730.4 2746.0 2771.9 2785.7 2789.4 2793.3 2626.4 2663.0 2673.9 2683.8 2714.2 2627.1 2647.4 2651.8 2655.2 2675.0 13594.9 13709.7 13738.7 13876.4 13919.4 7470.1 7768.9 7787.3 7790.1 7795.6 4874.0 5060.6 5075.0 5177.2 5189.3 1802.6 1827.8 1850.5 1883.1 1896.5 22500.2 22679.5 22698.5 22704.5 22727.7 6282.9 6485.9 6572.8 6676.6 6686.1 15688.1 15710.7 15749.3 15755.7 15779.7 7464.1 7656.8 7692.5 7695.7 7696.2 6899.1 6911.7 7108.2 7140.3 7179.9 4980.3 5108.6 5119.5 5130.0 5163.6 1375.3 1424.9 1496.9 1511.1 1539.6 798.9 818.1 840.2 846.9 857.7 7422.8 7634.2 7661.3 7666.9 7799.2 935.1 935.2 959.6 968.0 970.8 4667.2 4690.5 4723.2 4858.4 5024.4 17976.6 18532.9 18544.6 18618.2 18659.6 17356.8 18247.3 18778.4 18784.2 18791.5 10056.9 10133.7 10160.3 10274.1 10277.1 7144.7 7746.8 7876.1 7925.8 7942.6 15616.4 16160.1 16247.3 16391.8 16458.3 15849.9 16320.7 16338.3 16609.0 16994.2 11379.9 11585.1 11617.8 11621.2 11645.6 12746.2 12779.7 12968.5 13205.3 13225.1 9394.0 9865.5 10290.6 10291.2 10375.7 9897.0 10326.9 10354.8 10514.5 10672.0 8809.0 8910.6 8924.6 8938.0 8941.3 6625.5 6646.6 6685.0 6727.2 6811.7 6431.3 6446.7 6472.8 6575.8 6587.9 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#4] prototype.html Cycles:180 Average:5412.55 Median:5969.82 stddev:1510.41 (25.3%) stddev-sans-first:1468.95 03:53:56 INFO - PID 3586 | Values: 500.2 503.7 513.8 519.7 527.3 6140.9 6198.2 6214.4 6216.2 6222.0 5866.8 5934.9 5993.8 6079.0 6094.8 4837.0 4851.6 4857.0 4905.8 4910.4 4897.6 4905.8 4914.5 4922.7 4942.4 4744.9 4897.8 4907.9 4913.6 4943.5 4881.0 4899.1 4899.3 4959.5 4985.0 4385.6 4392.1 4402.7 4423.4 4437.6 5891.9 5956.7 5965.9 5973.8 5992.0 5649.9 5661.0 5674.2 5683.3 5699.9 6276.7 6342.1 6351.9 6366.9 6430.8 4751.2 4831.4 4832.3 4864.1 4873.6 6833.5 6916.2 6921.3 6923.2 6936.9 4929.7 4944.6 4948.6 5002.3 5004.4 4979.7 4983.4 4983.7 5000.8 5047.4 5630.5 5638.6 5648.7 5664.1 5688.8 6539.3 6599.9 6618.8 6646.3 6661.2 1648.4 1699.2 1700.2 1756.6 1774.3 1162.4 1209.6 1212.1 1224.9 1236.2 5594.6 5639.4 5640.5 5682.3 5712.0 6483.0 6505.8 6591.0 6614.3 6619.5 5524.0 5581.1 5646.1 5657.4 5673.0 3454.8 3491.5 3512.3 3522.4 3526.5 6232.3 6280.5 6326.5 6373.4 6374.4 6568.0 6590.0 6598.1 6611.4 6773.7 6224.8 6235.2 6236.2 6284.2 6388.6 6374.9 6453.4 6462.3 6475.3 6496.2 6466.2 6475.5 6494.2 6505.5 6573.7 6282.7 6286.3 6318.8 6320.5 6331.3 4933.8 4944.8 4963.7 4975.5 4997.4 6594.4 6594.9 6602.2 6633.0 6665.7 6245.6 6339.3 6377.8 6388.9 6447.6 6307.9 6340.7 6357.7 6413.7 6427.5 5815.0 6314.7 6365.4 6386.6 6411.2 6492.8 6526.7 6536.4 6545.6 6621.6 6291.7 6297.0 6345.7 6353.5 6389.2 03:53:56 INFO - PID 3586 | 03:53:56 INFO - PID 3586 | [#5] yui.html Cycles:180 Average:23204.99 Median:20595.35 stddev:30472.05 (148.0%) stddev-sans-first:30511.55 03:53:56 INFO - PID 3586 | Values: 910.4 923.3 924.5 932.1 949.7 18567.5 19223.6 19321.8 19326.7 22034.3 20672.7 20857.2 21596.0 21648.8 21832.9 1024.8 1054.7 1055.9 1056.0 1056.3 1049.8 1052.5 1053.3 1053.9 1054.8 1042.6 1093.5 1099.5 1099.6 1100.0 1094.8 1097.4 1097.4 1097.5 1097.6 797.6 799.3 799.9 800.2 800.3 18530.0 19379.3 19529.9 19553.0 19821.0 20587.9 20767.0 21182.5 21275.4 21303.7 15898.4 16048.9 16201.9 16251.4 16307.8 3575.6 3578.4 3584.6 3604.5 3618.2 120254.0 122511.4 123346.4 123837.0 127903.4 16214.1 16459.6 16553.3 16584.9 16617.0 28589.7 30560.5 30582.8 30588.8 30612.8 7684.2 7792.8 7801.4 7805.8 7827.8 3820.4 3917.0 3934.7 3953.7 3957.0 5086.9 5119.9 5143.2 5190.7 5225.1 940.4 956.4 975.3 976.8 977.1 657.1 673.4 678.4 700.6 710.7 11406.3 11614.0 12045.6 12140.4 12162.8 662.5 688.5 691.1 707.6 712.2 5157.8 6208.1 6327.7 6436.8 6457.4 100228.0 100257.5 101683.5 107825.0 108108.0 82916.6 90028.5 90289.0 90497.0 93308.5 76715.6 83062.6 83953.0 85547.7 85737.1 12212.8 12392.0 12575.9 12583.0 13161.9 36742.3 37474.4 37569.6 37605.1 37639.8 62341.4 62818.1 66125.3 67550.3 68182.3 19075.6 19536.6 19591.2 19863.4 20551.2 19188.3 19921.6 20288.5 20465.0 20467.4 19778.2 19930.3 20187.8 20420.6 20602.8 20166.9 20531.9 20976.4 21214.5 21533.8 19789.4 19829.2 20222.1 20406.3 20482.3 12750.8 13110.9 13532.5 13777.7 13959.0 14191.7 14680.3 15116.8 15257.0 15477.0 03:53:56 INFO - PID 3586 | -------- Summary: end -------- 03:53:56 INFO - PID 3586 | 03:53:57 INFO - TEST-INFO | 3586: exit 0 03:53:57 INFO - TEST-OK | dromaeo_css | took 1116471ms 03:53:57 INFO - TEST-START | kraken 03:53:57 INFO - Initialising browser for kraken test... 03:53:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40081/getInfo.html -profile /tmp/tmpWh44H4/profile 03:53:57 INFO - TEST-INFO | started process 3948 (/builds/slave/test/build/application/firefox/firefox http://localhost:40081/getInfo.html) 03:54:03 INFO - TEST-INFO | 3948: exit 0 03:54:03 INFO - Browser initialized. 03:54:03 INFO - Running cycle 1/1 for kraken test... 03:54:03 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWh44H4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:04 INFO - PID 4178 | 03:54:04 INFO - PID 4178 | (/builds/slave/test/build/application/firefox/firefox:4233): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:04 INFO - PID 4178 | 03:54:14 INFO - PID 4178 | RSS: Main: 173514752 03:54:14 INFO - PID 4178 | 03:54:17 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40081/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:18 INFO - PID 4178 | RSS: Main: 178413568 03:54:18 INFO - PID 4178 | 03:54:21 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40081/tests/kraken/driver.html?testName=audio-dft) 03:54:21 INFO - PID 4178 | RSS: Main: 178434048 03:54:21 INFO - PID 4178 | 03:54:24 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40081/tests/kraken/driver.html?testName=audio-fft) 03:54:25 INFO - PID 4178 | RSS: Main: 173629440 03:54:25 INFO - PID 4178 | 03:54:27 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40081/tests/kraken/driver.html?testName=audio-oscillator) 03:54:28 INFO - PID 4178 | RSS: Main: 174108672 03:54:28 INFO - PID 4178 | 03:54:30 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:31 INFO - PID 4178 | RSS: Main: 174915584 03:54:31 INFO - PID 4178 | 03:54:34 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40081/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:34 INFO - PID 4178 | RSS: Main: 176902144 03:54:34 INFO - PID 4178 | 03:54:38 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40081/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:39 INFO - PID 4178 | RSS: Main: 176111616 03:54:39 INFO - PID 4178 | 03:54:42 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40081/tests/kraken/driver.html?testName=json-parse-financial) 03:54:42 INFO - PID 4178 | RSS: Main: 177324032 03:54:42 INFO - PID 4178 | 03:54:44 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:45 INFO - PID 4178 | RSS: Main: 177135616 03:54:45 INFO - PID 4178 | 03:54:46 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:47 INFO - PID 4178 | RSS: Main: 174657536 03:54:47 INFO - PID 4178 | 03:54:49 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:50 INFO - PID 4178 | RSS: Main: 174706688 03:54:50 INFO - PID 4178 | 03:54:53 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:53 INFO - PID 4178 | RSS: Main: 175276032 03:54:53 INFO - PID 4178 | 03:54:57 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:57 INFO - PID 4178 | RSS: Main: 175153152 03:54:57 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:40081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40081/tests/kraken/driver.html?testName=ai-astar) 03:54:59 INFO - PID 4178 | RSS: Main: 176631808 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | __start_tp_report 03:54:59 INFO - PID 4178 | _x_x_mozilla_page_load 03:54:59 INFO - PID 4178 | _x_x_mozilla_page_load_details 03:54:59 INFO - PID 4178 | |i|pagename|runs| 03:54:59 INFO - PID 4178 | |0;ai-astar;108;107;103;109;110;108;109;102;111;112 03:54:59 INFO - PID 4178 | |1;audio-beat-detection;149;118;144;178;124;157;150;122;186;119 03:54:59 INFO - PID 4178 | |2;audio-dft;162;164;161;161;163;169;167;162;166;162 03:54:59 INFO - PID 4178 | |3;audio-fft;77;77;76;176;76;74;76;75;162;76 03:54:59 INFO - PID 4178 | |4;audio-oscillator;85;80;137;79;80;79;127;78;82;128 03:54:59 INFO - PID 4178 | |5;imaging-gaussian-blur;116;114;114;114;117;114;114;115;115;114 03:54:59 INFO - PID 4178 | |6;imaging-darkroom;155;156;151;149;153;153;151;155;150;152 03:54:59 INFO - PID 4178 | |7;imaging-desaturate;94;94;100;95;98;95;94;93;101;94 03:54:59 INFO - PID 4178 | |8;json-parse-financial;61;61;61;56;57;58;56;56;58;56 03:54:59 INFO - PID 4178 | |9;json-stringify-tinderbox;61;54;59;59;57;54;54;59;55;59 03:54:59 INFO - PID 4178 | |10;stanford-crypto-aes;90;80;81;80;82;83;81;82;81;80 03:54:59 INFO - PID 4178 | |11;stanford-crypto-ccm;134;130;145;137;129;129;142;126;130;178 03:54:59 INFO - PID 4178 | |12;stanford-crypto-pbkdf2;189;185;183;190;179;180;180;188;186;184 03:54:59 INFO - PID 4178 | |13;stanford-crypto-sha256-iterative;70;68;74;69;71;74;70;68;68;67 03:54:59 INFO - PID 4178 | __end_tp_report 03:54:59 INFO - PID 4178 | __start_cc_report 03:54:59 INFO - PID 4178 | _x_x_mozilla_cycle_collect,950 03:54:59 INFO - PID 4178 | __end_cc_report 03:54:59 INFO - PID 4178 | __startTimestamp1501325699892__endTimestamp 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | ------- Summary: start ------- 03:54:59 INFO - PID 4178 | Number of tests: 14 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.21 (2.9%) stddev-sans-first:3.41 03:54:59 INFO - PID 4178 | Values: 108.0 107.0 103.0 109.0 110.0 108.0 109.0 102.0 111.0 112.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.50 stddev:24.34 (16.3%) stddev-sans-first:25.76 03:54:59 INFO - PID 4178 | Values: 149.0 118.0 144.0 178.0 124.0 157.0 150.0 122.0 186.0 119.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.75 (1.7%) stddev-sans-first:2.85 03:54:59 INFO - PID 4178 | Values: 162.0 164.0 161.0 161.0 163.0 169.0 167.0 162.0 166.0 162.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.41 (51.9%) stddev-sans-first:41.29 03:54:59 INFO - PID 4178 | Values: 77.0 77.0 76.0 176.0 76.0 74.0 76.0 75.0 162.0 76.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.50 stddev:24.48 (30.8%) stddev-sans-first:25.67 03:54:59 INFO - PID 4178 | Values: 85.0 80.0 137.0 79.0 80.0 79.0 127.0 78.0 82.0 128.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.06 (0.9%) stddev-sans-first:1.01 03:54:59 INFO - PID 4178 | Values: 116.0 114.0 114.0 114.0 117.0 114.0 114.0 115.0 115.0 114.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:153.00 stddev:2.32 (1.5%) stddev-sans-first:2.28 03:54:59 INFO - PID 4178 | Values: 155.0 156.0 151.0 149.0 153.0 153.0 151.0 155.0 150.0 152.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:94.00 stddev:2.82 (3.0%) stddev-sans-first:2.92 03:54:59 INFO - PID 4178 | Values: 94.0 94.0 100.0 95.0 98.0 95.0 94.0 93.0 101.0 94.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.21 (3.8%) stddev-sans-first:2.06 03:54:59 INFO - PID 4178 | Values: 61.0 61.0 61.0 56.0 57.0 58.0 56.0 56.0 58.0 56.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:59.00 stddev:2.64 (4.5%) stddev-sans-first:2.40 03:54:59 INFO - PID 4178 | Values: 61.0 54.0 59.0 59.0 57.0 54.0 54.0 59.0 55.0 59.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:2.98 (3.7%) stddev-sans-first:1.05 03:54:59 INFO - PID 4178 | Values: 90.0 80.0 81.0 80.0 82.0 83.0 81.0 82.0 81.0 80.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:135.50 stddev:15.33 (11.3%) stddev-sans-first:16.19 03:54:59 INFO - PID 4178 | Values: 134.0 130.0 145.0 137.0 129.0 129.0 142.0 126.0 130.0 178.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:185.50 stddev:3.92 (2.1%) stddev-sans-first:3.79 03:54:59 INFO - PID 4178 | Values: 189.0 185.0 183.0 190.0 179.0 180.0 180.0 188.0 186.0 184.0 03:54:59 INFO - PID 4178 | 03:54:59 INFO - PID 4178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:2.47 (3.5%) stddev-sans-first:2.62 03:54:59 INFO - PID 4178 | Values: 70.0 68.0 74.0 69.0 71.0 74.0 70.0 68.0 68.0 67.0 03:54:59 INFO - PID 4178 | -------- Summary: end -------- 03:54:59 INFO - PID 4178 | 03:55:00 INFO - PID 4178 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:00 INFO - TEST-INFO | 4178: exit 0 03:55:00 INFO - TEST-OK | kraken | took 63448ms 03:55:00 INFO - SUITE-END | took 1179s 03:55:01 INFO - Completed test suite (00:19:40) 03:55:01 INFO - javascript benchmark 03:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8406.544599910663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.2827949571597, 3144.8113113213194, 3157.2580443595753, 3190.34597907429, 3193.058047875877, 6232.189815324002, 6233.127362169294, 6258.749650014, 6268.404501572355, 6281.1520444739945, 6058.515318774498, 6148.35442278561, 6183.567150299481, 6185.690715464231, 6214.502839772818, 5668.291463567064, 5713.685747283897, 5720.542356611482, 5734.541236701054, 5765.962126817171, 5655.7172141392975, 5718.0, 5799.507041901444, 5812.941870581303, 5823.359430462646, 5715.0855863061915, 5737.39757325479, 5768.596198266123, 5771.0, 5847.883042339151, 5484.561235101182, 5609.719514024323, 5723.627964182315, 5754.251947246852, 5768.567357448187, 5146.716930568818, 5625.578081643893, 5637.3517045539875, 5638.4925356718095, 5655.802046928337, 6024.457798798129, 6095.08573713942, 6190.690465476753, 6214.844628884269, 6220.533459990474, 6423.903641445382, 6507.186601674791, 6578.0, 6680.1983761948395, 6695.096162018114, 6679.198496180489, 6731.259561448237, 6739.090222819906, 6741.157355330583, 6744.6627668616375, 6167.845803854894, 6220.129181914535, 6230.376962303733, 6231.813045608594, 6233.906491402633, 6865.622390768555, 6871.0, 6876.140482439695, 6876.140482439695, 6878.69045892926, 6434.903476447857, 6556.8360790980605, 6563.7702680405955, 6565.048068030204, 6569.605823650596, 6721.596704197764, 6764.526483146133, 6766.69549870257, 6790.32096790317, 6807.774600571945, 6640.435562977104, 6641.103451034145, 6655.700493477805, 6692.063111164441, 6765.695543700447, 6530.706118224692, 6681.164854393201, 6711.899321510181, 6780.423663988518, 6801.727930882709, 5428.4842939920645, 5468.207109969032, 5470.124780035176, 5470.617056805985, 5484.012877682056, 4634.83778067766, 4635.884102897455, 4643.303504474288, 4719.646026548023, 4766.475687674353, 5722.942770572325, 5774.855628609318, 5805.245318108618, 5810.41895810424, 5826.475617194473, 6666.933330666729, 6667.399934005963, 6737.9663101685155, 6751.493637977073, 6753.527253092237, 5670.347909990322, 5704.201411802351, 5803.767849285981, 5815.73829177688, 5834.679092649945, 5952.5833191676165, 5957.046872500466, 5964.7315870785915, 5965.28416590012, 5966.820995370146, 6487.448566871774, 6509.056186852879, 6543.901841472381, 6580.309067547934, 6580.769673061515, 6683.365080317362, 6722.260551339251, 6728.629925354153, 6795.048693182859, 6836.418904393182, 6346.587471814318, 6422.389872962061, 6506.25178104524, 6560.901586476302, 6562.146920900253, 6632.071509988702, 6638.435732962752, 6643.933560664332, 6645.800625981228, 6645.833854153685, 6718.428933540704, 6825.419839313516, 6833.555818871758, 6842.486813488908, 6842.692078856364, 6593.406593406617, 6593.736250550116, 6594.406503414716, 6594.90107648376, 6595.538312318284, 6249.9062514063235, 6606.47148228131, 6607.669616519251, 6614.70233839488, 6643.202815662152, 6339.017452294902, 6412.9679351602945, 6430.871382572229, 6466.676666166579, 6563.1796025496815, 6553.344665533408, 6565.179352580927, 6581.0, 6612.966935165486, 6676.432503237279, 6243.313235544178, 6329.145565348803, 6337.144485494399, 6341.8731625368155, 6421.678916054272], "value": 6108.077947726222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.3428305930667, 838.7651457591875, 868.4919322196515, 876.0801158783275, 1174.3012907320142, 30625.693743062562, 31182.84408577957, 40914.7954260229, 42033.369499457534, 42040.15919681604, 41802.37296440556, 42348.78825605875, 42395.788021059925, 42471.0, 42494.787526062326, 7416.703331866745, 7782.64978075988, 8120.187981201862, 8129.349652027853, 8133.227343402367, 7824.0, 7944.205579442068, 7962.323202527792, 7991.041075071, 8004.759857204293, 7964.084130325029, 8004.399670024772, 8016.398770092237, 8020.879686804703, 8021.278084972351, 7974.444983228273, 7974.760757177294, 7993.360531157494, 7995.920040799605, 8002.8799568006525, 7869.0, 7958.204179582053, 7962.681492740284, 7966.163552826985, 7966.482178658426, 37527.249455010744, 37741.622583774086, 37825.0, 37857.621423785684, 37891.0, 3478.7912725236565, 3493.807840568768, 3525.383057964846, 3528.858845646171, 3530.9823450882836, 30947.0, 31041.37917241665, 31049.53425698594, 31066.0, 31097.689023109706, 4765.0, 4816.277558366238, 4819.108464933998, 4821.083994041156, 4851.078295123915, 187957.0, 188005.0, 188647.0, 190208.0489597557, 190412.0, 47164.0, 47258.29112563314, 47344.28983565249, 47365.28952065722, 47568.0, 49162.0, 49382.25926611032, 49436.75281623569, 49438.25842612363, 49444.75277623661, 13251.0, 13561.457541698419, 15480.845191548166, 15750.9212453937, 15801.209939502978, 11117.110631149488, 11835.11236657254, 12212.755744885053, 12262.080343974238, 12271.69320766988, 13549.796753048711, 13592.524261650795, 13716.725665486634, 13720.245386503839, 13916.02587818843, 5498.5876059295715, 5664.8867022659315, 5687.914681279784, 5691.573132015115, 5719.628224165416, 980.547365088171, 981.4356744871585, 982.6069572171189, 1020.3571749797728, 1025.7179275699243, 22232.333030009126, 22288.442788930406, 22289.554208916055, 22387.0, 22885.199018034287, 1073.8603981482356, 1096.5568311665459, 1099.796537640539, 1101.3777215873006, 1110.8944650258213, 11763.647090587296, 11782.057435405148, 11891.70270743221, 12006.039516838631, 12034.81947770784, 218183.0, 219892.0, 220567.0, 221104.0, 221335.0, 50104.749476252386, 50596.0, 50605.24092138621, 50858.0, 51015.74492127515, 1449.2608769527617, 1459.1318165691184, 1496.5211132437732, 1498.887583431247, 1514.0, 21569.137234510443, 21802.672959905933, 21909.452263693536, 22085.779142208372, 22193.556128877655, 36101.0, 36281.45577816282, 36283.0, 36284.81857590695, 36332.27335453223, 180172.0, 180369.0, 180833.0, 180841.0, 180889.0, 32263.677363226067, 34243.65756342404, 35173.824130879184, 35282.82358588191, 35394.0, 42896.78551607222, 44766.77616611896, 45017.32474012958, 45213.321800172365, 45276.77361613171, 30585.847070764503, 31086.0, 31608.525872112397, 31775.841120795172, 31957.520637189995, 31476.842615786776, 31782.0, 31949.20126996844, 32122.0, 32215.194620134684, 36014.8199259002, 36205.27589448249, 36210.8189459051, 36379.0, 36437.63562364342, 29919.0, 30633.54049689301, 32025.839870800497, 32477.512837306986, 32621.673783261864, 23450.53098938046, 23522.64716029227, 24008.51982960296, 24211.757882421654, 24517.264482065566], "value": 16905.307155916253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3830955104161, 567.9346875109363, 568.4457653787557, 582.0392230868938, 590.3565114025713, 21466.677999829997, 22255.22106726265, 22255.888720556373, 22279.0, 22323.553528929413, 24926.62610060846, 25692.0, 25875.74124258757, 27010.0, 27025.1892443227, 6301.338359472258, 6471.352864713538, 6480.902786458183, 6485.124508191405, 6495.707693153796, 6436.549441539094, 6439.484841212692, 6484.935150648504, 6508.414242718154, 6512.6092434454085, 5819.592628516006, 6372.0, 6393.712282947278, 6399.200099987502, 6417.647029413381, 6370.426661600455, 6377.96811015942, 6413.486921046305, 6434.485241180718, 6437.678116094224, 5889.4993925515955, 5949.732262048218, 5949.9702501487645, 5959.344472108065, 5962.747822957184, 27510.587341189897, 28112.578311325346, 28389.72882169442, 28773.0, 28814.135575932756, 1805.873588848781, 1841.171472837215, 1842.4104286628285, 1845.4371416717895, 1845.713914343279, 19010.904945475184, 19344.70982935257, 19497.610047798964, 19502.80497195024, 19619.313324033592, 2233.1960494222067, 2294.128231272123, 2306.7923886850094, 2323.5585238804574, 2325.5581439526436, 134148.32925835406, 137539.31230343884, 138056.0, 138349.0, 138446.0, 14496.492622758153, 14557.708845823025, 14655.680988711067, 14698.33857476416, 14889.404423823142, 23446.06215751351, 23462.061517539107, 23513.412164695677, 23527.17654882071, 23540.176093836635, 9891.752706182258, 10072.647457339104, 10145.28982971185, 10201.795964080826, 10328.328658637314, 9429.481378524248, 9474.857877131848, 9480.668176613923, 9578.616855325849, 9720.07659272368, 8714.389992700577, 8935.0, 9135.937811441154, 9403.106704863027, 9422.434653920787, 2691.3406215477335, 2762.811990843956, 2764.543850264684, 2766.169154228856, 2885.422915416925, 920.3741455810114, 932.7201839448138, 933.9066093390607, 974.9902500974899, 975.6292608808608, 18366.449006529827, 19001.809981900282, 19063.428097157106, 19833.702494462595, 22747.0, 975.6341371985505, 999.9850002249972, 1003.4882210072915, 1030.8093002794358, 1033.7622346860264, 10772.353658780497, 11123.332600044023, 11166.274192177483, 11270.267432616854, 11349.452614011754, 495639.0, 500516.0, 503742.0, 519117.0, 523209.0, 111901.0, 114329.0, 115047.42476287566, 115435.42282288535, 115514.0, 1224.6203676860202, 1264.2856785915928, 1282.044876566945, 1290.4451086033096, 1290.806379043151, 19151.904240478707, 20683.58632827365, 20924.58150837005, 21014.474638133557, 21080.367588972356, 53497.73251133719, 54139.0, 54930.725346373016, 57002.0, 57070.0, 70416.64791676009, 70479.0, 71123.64438177776, 71484.64257678678, 71601.28398715946, 12109.69725756863, 14398.856011439751, 14574.708505829612, 14577.344019518934, 14745.894057945912, 18690.0, 18934.905325473836, 22270.888645556668, 23080.0, 23279.76720232776, 17610.647787044443, 18184.545386364916, 18340.724889126406, 18649.254029838656, 19515.12181951844, 16264.0, 16715.74926376081, 16974.830251697324, 17284.0, 17571.297148113932, 19920.203191872162, 19994.20023199056, 20069.0, 20305.59388812245, 20313.187472500933, 13954.441822327399, 14530.128192308495, 14706.705865882837, 14796.48212312564, 14832.703345933236, 18666.440006799818, 18883.150258238686, 18889.90555047216, 18890.149943252312, 18927.432177034712], "value": 11933.817972584704, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.878420942115, 1377.786443101319, 1387.805707200992, 1406.4374250299873, 1412.2091628687936, 13544.864551354496, 14146.151230926152, 14221.21783301918, 14222.28888555572, 14243.643908902282, 13573.796393054088, 14451.421943122288, 14503.129812211275, 14507.27463626817, 14550.981431299813, 2736.7400096990755, 2771.514984877648, 2780.4995100881833, 2785.4150628368066, 2794.6786119596304, 2601.9722209727147, 2668.1995401379604, 2679.7990150738674, 2714.7556719895206, 2730.3856632257684, 2746.0, 2771.9168424947184, 2785.6796468406087, 2789.428167225714, 2793.329600895791, 2626.3565426470445, 2662.986685066572, 2673.9465210695776, 2683.771879390264, 2714.24001279642, 2627.1199148285154, 2647.3646324882084, 2651.7536757723838, 2655.1768951624863, 2675.023616380027, 13594.93202533991, 13709.725805483935, 13738.65653358664, 13876.444942202299, 13919.373628186755, 7470.140933792629, 7768.922310776877, 7787.29914307715, 7790.104138024143, 7795.610219489003, 4873.975630121862, 5060.569851562622, 5074.99537682617, 5177.171652535576, 5189.273501709764, 1802.6034272460038, 1827.798942116366, 1850.5096149520389, 1883.0867029490687, 1896.5163883209832, 22500.212492562845, 22679.546409071725, 22698.54602907949, 22704.54590908189, 22727.659085113737, 6282.921368529388, 6485.935140648533, 6572.769953051716, 6676.6327851967635, 6686.063951046857, 15688.137152456724, 15710.685786284439, 15749.291281892343, 15755.68488630221, 15779.684406312039, 7464.1416237132335, 7656.770296891103, 7692.499987500794, 7695.653695583712, 7696.230376962371, 6899.137607799025, 6911.6544172791155, 7108.218096009435, 7140.285971402818, 7179.856402871913, 4980.252962055721, 5108.6168537359845, 5119.539241468211, 5130.0, 5163.638545301793, 1375.2917247617286, 1424.9002569820013, 1496.8503149685162, 1511.093343993617, 1539.5535294764618, 798.9280964713204, 818.1123481023037, 840.1976112812249, 846.949183049019, 857.7212405968086, 7422.777316680508, 7634.160242373335, 7661.348785353307, 7666.8849967250535, 7799.220077992155, 935.1350001248818, 935.2144198872843, 959.5654496527736, 967.970960871175, 970.8349580571179, 4667.206574882278, 4690.507496712864, 4723.220668589713, 4858.416989961227, 5024.422191447957, 17976.550586235448, 18532.907335463235, 18544.629107418044, 18618.16218270154, 18659.626807463774, 17356.82643173552, 18247.27010919575, 18778.436646900616, 18784.248630054917, 18791.530211744543, 10056.949715251378, 10133.695989120339, 10160.288779785493, 10274.126699230648, 10277.126444252173, 7144.714211431485, 7746.845063098819, 7876.133625301098, 7925.801854953672, 7942.6028698566, 15616.375344986527, 16160.11119388445, 16247.268872900984, 16391.83608163903, 16458.259378327766, 15849.890507664353, 16320.67358652844, 16338.346466141222, 16609.0, 16994.235259413108, 11379.943100284776, 11585.073194144617, 11617.825732613848, 11621.24461909973, 11645.59240426581, 12746.171498852545, 12779.744405112031, 12968.481260749464, 13205.273709946045, 13225.140365876186, 9393.953030234805, 9865.506724663881, 10290.639827605997, 10291.176705863663, 10375.740606484596, 9897.0, 10326.896731032894, 10354.792904142025, 10514.526846291783, 10672.0, 8809.0, 8910.599023044108, 8924.553772311228, 8938.0, 8941.284697224077, 6625.4699624029, 6646.567973081735, 6685.0, 6727.192736871607, 6811.659417029228, 6431.260405053292, 6446.67766611677, 6472.773452929125, 6575.80272591823, 6587.934120658732], "value": 6262.590231343489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.2284933687784, 503.67282211373043, 513.8175947538623, 519.695977852956, 527.2539356810114, 6140.907886381708, 6198.194234749481, 6214.378562143784, 6216.1918950536365, 6221.968890155548, 5866.823995280149, 5934.87237424889, 5993.760249590022, 6079.0, 6094.7505761318935, 4837.0, 4851.587615052725, 4857.0, 4905.779239934193, 4910.410750709911, 4897.6081913447015, 4905.779239934212, 4914.508549145093, 4922.655414121013, 4942.382202224722, 4744.884952036269, 4897.755112244374, 4907.926381104268, 4913.582345500618, 4943.480934501879, 4881.048195601859, 4899.1426500362295, 4899.289603007562, 4959.504049595048, 4985.033904826622, 4385.649148068147, 4392.121575684876, 4402.713823601455, 4423.358613001129, 4437.5784300491405, 5891.882162356772, 5956.702164891782, 5965.850853728648, 5973.790917317917, 5992.0, 5649.9152512711935, 5661.0, 5674.233978412903, 5683.2895888014, 5699.886002279973, 6276.717547710364, 6342.143810585558, 6351.904721429182, 6366.87266254677, 6430.807075787734, 4751.239801631757, 4831.444383895861, 4832.251001094836, 4864.100141473838, 4873.585745211662, 6833.487488438387, 6916.23921368649, 6921.307869213088, 6923.238443771181, 6936.93063069373, 4929.704217746875, 4944.554990050912, 4948.579370753454, 5002.299678045077, 5004.42272229802, 4979.676321039121, 4983.426905905795, 4983.700977941335, 5000.774965126578, 5047.384836852246, 5630.493255607015, 5638.633488823213, 5648.661080335193, 5664.063475884221, 5688.77244910199, 6539.332470220063, 6599.901001484982, 6618.801435956929, 6646.26891041985, 6661.2006559213205, 1648.3571407151221, 1699.1674079700858, 1700.200905574378, 1756.5872020075271, 1774.308019872251, 1162.39555431177, 1209.6492017314881, 1212.090931801149, 1224.9020078393708, 1236.1594116001206, 5594.580406469531, 5639.379668236491, 5640.520555752807, 5682.318121825408, 5712.0, 6483.0, 6505.837354066091, 6591.00109450199, 6614.272430032693, 6619.470442364599, 5524.0, 5581.10702287632, 5646.096624540136, 5657.405972372924, 5673.007223735913, 3454.809985450824, 3491.546099007164, 3512.332656795201, 3522.4011917973494, 3526.536487357769, 6232.25212974446, 6280.528960327993, 6326.481644405309, 6373.3945275198785, 6374.394432528902, 6567.9671601641685, 6590.0, 6598.074145883192, 6611.371919667624, 6773.695183716744, 6224.782132625336, 6235.158253635792, 6236.220472440945, 6284.24589049317, 6388.616682999035, 6374.872502550016, 6453.419192272718, 6462.256840463407, 6475.287718351072, 6496.155499784998, 6466.159399278064, 6475.514336424882, 6494.220693516808, 6505.479561634963, 6573.737050517926, 6282.717277722605, 6286.277078136073, 6318.778842740482, 6320.5259605528845, 6331.303556608861, 4933.827316043921, 4944.826931057396, 4963.677360971526, 4975.527324904128, 4997.400311962588, 6594.439472644879, 6594.934050659432, 6602.20773507163, 6633.0, 6665.66671666405, 6245.594036387621, 6339.3343698912795, 6377.840553986002, 6388.93611063902, 6447.6453795041725, 6307.873842523216, 6340.714667839866, 6357.682115894094, 6413.679316034273, 6427.453666438218, 5814.970925145347, 6314.747410103544, 6365.427111559982, 6386.552941294065, 6411.230652321565, 6492.805215843532, 6526.706298216497, 6536.444402225864, 6545.607263564201, 6621.602703837592, 6291.748330066746, 6296.968515157395, 6345.746170153142, 6353.4599559038, 6389.233292004989], "value": 4969.930191593184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.3627460777453, 923.335198656967, 924.4591913730467, 932.1284598900033, 949.7198326493685, 18567.535811604717, 19223.615527689457, 19321.806781932177, 19326.710099348522, 22034.33896983093, 20672.68990965133, 20857.165713371483, 21596.0, 21648.783512164875, 21832.8908355458, 1024.8462730590416, 1054.7046826888484, 1055.9102476289524, 1056.033729137838, 1056.287006270768, 1049.8110340138771, 1052.5158427123533, 1053.336398069219, 1053.852460655505, 1054.8154073037226, 1042.6194439029737, 1093.5079214353573, 1099.5107177306102, 1099.587654629514, 1100.0374672161859, 1094.819354806456, 1097.358045543358, 1097.4238524774516, 1097.4786976186329, 1097.6103483263487, 797.6051854332143, 799.2606838674203, 799.856025915335, 800.2397722163968, 800.3117319105622, 18530.0, 19379.321723739602, 19529.902350488297, 19553.02234888264, 19821.0, 20587.897060514602, 20767.0, 21182.470438239012, 21275.361739147695, 21303.68044479334, 15898.364065437485, 16048.919755401148, 16201.918990404973, 16251.431199907947, 16307.755383669255, 3575.5530558680166, 3578.427451607756, 3584.6415358464205, 3604.5494313210847, 3618.203995121069, 120254.0, 122511.38744306221, 123346.38326808308, 123837.0, 127903.36048319699, 16214.10822404779, 16459.58851028734, 16553.25510352037, 16584.917075414545, 16617.0, 28589.71410285912, 30560.541591875695, 30582.847085764875, 30588.847055765025, 30612.846935765625, 7684.231576842271, 7792.766217013499, 7801.414893882981, 7805.80485487856, 7827.84344313122, 3820.426935959573, 3916.9608303917166, 3934.6852251819787, 3953.7034722395933, 3956.9604303957167, 5086.92369614456, 5119.87200319995, 5143.151380022255, 5190.740462976836, 5225.111731005738, 940.4122423485321, 956.4404823178519, 975.3124047546463, 976.7851072763981, 977.0766625538797, 657.1260223902199, 673.4072454715806, 678.3792829560897, 700.6356694518822, 710.7015053677468, 11406.258593191416, 11614.0, 12045.578404755792, 12140.392980350947, 12162.75674486523, 662.4733336997002, 688.50771698236, 691.0912150522047, 707.6037419045351, 712.2023333866103, 5157.767900444489, 6208.0998255253635, 6327.715252813635, 6436.806895793134, 6457.3865482779065, 100228.0, 100257.49871250597, 101683.4915825431, 107825.0, 108108.0, 82916.58541707252, 90028.5498572503, 90289.0, 90497.0, 93308.53345733363, 76715.61642191753, 83062.58468707617, 83953.0, 85547.71678424704, 85737.14262857416, 12212.816807747713, 12392.0, 12575.931045861204, 12583.0, 13161.947044236247, 36742.26515469622, 37474.437883432314, 37569.62430375771, 37605.05987350338, 37639.81180094082, 62341.37658623356, 62818.08417146727, 66125.33874661192, 67550.3244967544, 68182.3181768176, 19075.618487630447, 19536.60926781428, 19591.216351345785, 19863.404097876508, 20551.177952881717, 19188.273055425077, 19921.60156796885, 20288.492787680425, 20465.0, 20467.385978420672, 19778.208871644973, 19930.30243941455, 20187.79812201859, 20420.591588168452, 20602.79397206069, 20166.899165504077, 20531.897340513202, 20976.37070887876, 21214.46963825917, 21533.784662153805, 19789.406317810488, 19829.20683172657, 20222.090005949474, 20406.28577999763, 20482.283120090724, 12750.808737868754, 13110.934445327712, 13532.526361577298, 13777.724445511234, 13959.022868399115, 14191.716165676422, 14680.313519535495, 15116.848831511545, 15257.0, 15476.993995390263], "value": 9201.670138636651, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 103.0, 109.0, 110.0, 108.0, 109.0, 102.0, 111.0, 112.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 144.0, 178.0, 124.0, 157.0, 150.0, 122.0, 186.0, 119.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 161.0, 163.0, 169.0, 167.0, 162.0, 166.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 176.0, 76.0, 74.0, 76.0, 75.0, 162.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 137.0, 79.0, 80.0, 79.0, 127.0, 78.0, 82.0, 128.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 151.0, 149.0, 153.0, 153.0, 151.0, 155.0, 150.0, 152.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 100.0, 95.0, 98.0, 95.0, 94.0, 93.0, 101.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 56.0, 57.0, 58.0, 56.0, 56.0, 58.0, 56.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 59.0, 59.0, 57.0, 54.0, 54.0, 59.0, 55.0, 59.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 80.0, 81.0, 80.0, 82.0, 83.0, 81.0, 82.0, 81.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 145.0, 137.0, 129.0, 129.0, 142.0, 126.0, 130.0, 178.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 183.0, 190.0, 179.0, 180.0, 180.0, 188.0, 186.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 74.0, 69.0, 71.0, 74.0, 70.0, 68.0, 68.0, 67.0], "value": 69.9, "unit": "score"}]}]} 03:55:01 INFO - Return code: 0 03:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:01 INFO - # TBPL SUCCESS # 03:55:01 INFO - Running post-action listener: _package_coverage_data 03:55:01 INFO - Running post-action listener: _resource_record_post_action 03:55:01 INFO - [mozharness: 2017-07-29 10:55:01.192566Z] Finished run-tests step (success) 03:55:01 INFO - Running post-run listener: _resource_record_post_run 03:55:01 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 5349376; Write bytes: 440078336; Read time: 2476; Write time: 308632 03:55:01 INFO - TinderboxPrint: CPU usage
13.2% 03:55:01 INFO - TinderboxPrint: I/O read bytes / time
5,349,376 / 2,476 03:55:01 INFO - TinderboxPrint: I/O write bytes / time
440,078,336 / 308,632 03:55:01 INFO - TinderboxPrint: CPU idle
8,300.9 (86.8%) 03:55:01 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 03:55:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116060160; Read time: 0; Write time: 88008 03:55:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:01 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2854912; Write bytes: 324018176; Read time: 1564; Write time: 220624 03:55:01 INFO - Running post-run listener: _upload_blobber_files 03:55:01 INFO - Blob upload gear active. 03:55:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:01 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:55:01 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:55:01 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:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:03 INFO - (blobuploader) - INFO - Done attempting. 03:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:03 INFO - (blobuploader) - INFO - Done attempting. 03:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:04 INFO - (blobuploader) - INFO - Done attempting. 03:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:08 INFO - (blobuploader) - INFO - Done attempting. 03:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:08 INFO - Return code: 0 03:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9378a84102eb39713173cca8d3c92a85df9c48b1f83caf8be22a1eb850a50098e10c9a36c53c9ef3ecd3e3b6a1548c1a04d96f6d32faf96a9d4938e8c0f5c94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f966b24236c37a9a678d3b68ef054e7d99f19f2ecffeec78c3afc90bd5cb0b9acbd300f29d82fefbffdf0277356784fb3745f11977282e617efa4109fe0ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6644b44f6851335196cdfdd3453e5a773f8c5814c6ca16106670065bf072fafb7b00735dc151f7992ca8c5b107631f79933904ac0b4e968b14eb71c84f28dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db3994ca2cc07c55109a0c9ea8f57b54a5af94789d185c629afed39b9387a1395c4f1d89fb7bf42dd21ec5969777ece56980001a09d8dd1086995456a5243913"} 03:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:08 INFO - Contents: 03:55:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9378a84102eb39713173cca8d3c92a85df9c48b1f83caf8be22a1eb850a50098e10c9a36c53c9ef3ecd3e3b6a1548c1a04d96f6d32faf96a9d4938e8c0f5c94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f966b24236c37a9a678d3b68ef054e7d99f19f2ecffeec78c3afc90bd5cb0b9acbd300f29d82fefbffdf0277356784fb3745f11977282e617efa4109fe0ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6644b44f6851335196cdfdd3453e5a773f8c5814c6ca16106670065bf072fafb7b00735dc151f7992ca8c5b107631f79933904ac0b4e968b14eb71c84f28dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db3994ca2cc07c55109a0c9ea8f57b54a5af94789d185c629afed39b9387a1395c4f1d89fb7bf42dd21ec5969777ece56980001a09d8dd1086995456a5243913"} 03:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:08 INFO - Copying logs to upload dir... 03:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.096934 ========= master_lag: -0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-29 03:55:07.447053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:07.455010) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9378a84102eb39713173cca8d3c92a85df9c48b1f83caf8be22a1eb850a50098e10c9a36c53c9ef3ecd3e3b6a1548c1a04d96f6d32faf96a9d4938e8c0f5c94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f966b24236c37a9a678d3b68ef054e7d99f19f2ecffeec78c3afc90bd5cb0b9acbd300f29d82fefbffdf0277356784fb3745f11977282e617efa4109fe0ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6644b44f6851335196cdfdd3453e5a773f8c5814c6ca16106670065bf072fafb7b00735dc151f7992ca8c5b107631f79933904ac0b4e968b14eb71c84f28dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db3994ca2cc07c55109a0c9ea8f57b54a5af94789d185c629afed39b9387a1395c4f1d89fb7bf42dd21ec5969777ece56980001a09d8dd1086995456a5243913"} build_url:https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9378a84102eb39713173cca8d3c92a85df9c48b1f83caf8be22a1eb850a50098e10c9a36c53c9ef3ecd3e3b6a1548c1a04d96f6d32faf96a9d4938e8c0f5c94f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f966b24236c37a9a678d3b68ef054e7d99f19f2ecffeec78c3afc90bd5cb0b9acbd300f29d82fefbffdf0277356784fb3745f11977282e617efa4109fe0ec58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6644b44f6851335196cdfdd3453e5a773f8c5814c6ca16106670065bf072fafb7b00735dc151f7992ca8c5b107631f79933904ac0b4e968b14eb71c84f28dfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db3994ca2cc07c55109a0c9ea8f57b54a5af94789d185c629afed39b9387a1395c4f1d89fb7bf42dd21ec5969777ece56980001a09d8dd1086995456a5243913"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:07.482031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:07.482376) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501323619.10324-1712879380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:07.563377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-29 03:55:07.566706) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-29 03:55:07.567014) ========= ========= Total master_lag: 0.11 =========