builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1503363346.16 results: success (0) revision: 128a79130ecd6f277190d031a623f991c73c5272 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.156537) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.156982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.157263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.172981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.173293) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 17:55:46-- 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% 65.5M=0s 2017-08-21 17:55:46 (65.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.337645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.341070) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020015 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:46.390723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 17:55:46.394087) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 128a79130ecd6f277190d031a623f991c73c5272 --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 128a79130ecd6f277190d031a623f991c73c5272 --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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 17:55:46,998 truncating revision to first 12 chars 2017-08-21 17:55:46,998 Setting DEBUG logging. 2017-08-21 17:55:46,998 attempt 1/10 2017-08-21 17:55:46,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/128a79130ecd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 17:55:48,210 unpacking tar archive at: mozilla-central-128a79130ecd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.506163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-21 17:55:47.917925) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:47.918253) ========= script_repo_revision: 128a79130ecd6f277190d031a623f991c73c5272 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:47.918622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:47.918895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 17:55:47.930445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-21 17:55:47.930738) ========= /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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:48 INFO - MultiFileLogger online at 20170821 17:55:48 in /builds/slave/test 17:55:48 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 17:55:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:48 INFO - {'append_to_log': False, 17:55:48 INFO - 'base_work_dir': '/builds/slave/test', 17:55:48 INFO - 'blob_upload_branch': 'Firefox', 17:55:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:48 INFO - 'branch': 'Firefox', 17:55:48 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:48 INFO - 'code_coverage': False, 17:55:48 INFO - 'config_files': ('talos/linux_config.py',), 17:55:48 INFO - 'default_actions': ('clobber', 17:55:48 INFO - 'read-buildbot-config', 17:55:48 INFO - 'download-and-extract', 17:55:48 INFO - 'populate-webroot', 17:55:48 INFO - 'create-virtualenv', 17:55:48 INFO - 'install', 17:55:48 INFO - 'setup-mitmproxy', 17:55:48 INFO - 'run-tests'), 17:55:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:48 INFO - 'disable_ccov_upload': False, 17:55:48 INFO - 'download_minidump_stackwalk': True, 17:55:48 INFO - 'download_symbols': 'ondemand', 17:55:48 INFO - 'enable_stylo': False, 17:55:48 INFO - 'enable_webrender': False, 17:55:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:48 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:48 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:48 INFO - 'gecko_profile': False, 17:55:48 INFO - 'gecko_profile_interval': 0, 17:55:48 INFO - 'installer_path': 'installer.exe', 17:55:48 INFO - 'log_level': 'info', 17:55:48 INFO - 'log_name': 'talos', 17:55:48 INFO - 'log_to_console': True, 17:55:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:48 INFO - 'opt_config_files': (), 17:55:48 INFO - 'pip_index': False, 17:55:48 INFO - 'suite': 'dromaeojs-e10s', 17:55:48 INFO - 'system_bits': '32', 17:55:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:48 INFO - 'title': 'talos-linux64-ix-029', 17:55:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:48 INFO - 'use_talos_json': True, 17:55:48 INFO - 'verify': 'False', 17:55:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:48 INFO - 'work_dir': 'build'} 17:55:48 INFO - [mozharness: 2017-08-22 00:55:48.676733Z] Running clobber step. 17:55:48 INFO - Running pre-action listener: _resource_record_pre_action 17:55:48 INFO - Running main action method: clobber 17:55:48 INFO - rmtree: /builds/slave/test/build 17:55:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:50 INFO - Running post-action listener: _resource_record_post_action 17:55:50 INFO - [mozharness: 2017-08-22 00:55:50.381849Z] Finished clobber step (success) 17:55:50 INFO - [mozharness: 2017-08-22 00:55:50.381945Z] Running read-buildbot-config step. 17:55:50 INFO - Running pre-action listener: _resource_record_pre_action 17:55:50 INFO - Running main action method: read_buildbot_config 17:55:50 INFO - Using buildbot properties: 17:55:50 INFO - { 17:55:50 INFO - "project": "", 17:55:50 INFO - "product": "firefox", 17:55:50 INFO - "who": "kwierso@gmail.com", 17:55:50 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:55:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:55:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:55:50 INFO - "stage_platform": "linux64-pgo", 17:55:50 INFO - "basedir": "/builds/slave/test", 17:55:50 INFO - "buildnumber": 122, 17:55:50 INFO - "platform": "ubuntu64_hw", 17:55:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:55:50 INFO - "slavebuilddir": "test", 17:55:50 INFO - "taskId": "dbsxMMKwTLK9pOMTzLgOAA", 17:55:50 INFO - "branch": "mozilla-central", 17:55:50 INFO - "script_repo_revision": "production", 17:55:50 INFO - "revision": "128a79130ecd6f277190d031a623f991c73c5272", 17:55:50 INFO - "slavename": "talos-linux64-ix-029", 17:55:50 INFO - "repo_path": "mozilla-central" 17:55:50 INFO - } 17:55:50 INFO - Finding installer, test and symbols from parent task. 17:55:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dbsxMMKwTLK9pOMTzLgOAA'}, attempt #1 17:55:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dbsxMMKwTLK9pOMTzLgOAA'}, attempt #1 17:55:51 INFO - Task dependencies: PE88c5nlQNS-k1dI4pmmxQ 17:55:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ'}, attempt #1 17:55:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 17:55:51 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.test_packages.json 17:55:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.crashreporter-symbols.zip 17:55:51 INFO - Running post-action listener: _resource_record_post_action 17:55:51 INFO - [mozharness: 2017-08-22 00:55:51.736503Z] Finished read-buildbot-config step (success) 17:55:51 INFO - [mozharness: 2017-08-22 00:55:51.736719Z] Running download-and-extract step. 17:55:51 INFO - Running pre-action listener: _resource_record_pre_action 17:55:51 INFO - Running main action method: download_and_extract 17:55:51 INFO - mkdir: /builds/slave/test/build/tests 17:55:51 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')]} 17:55:51 INFO - trying https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.test_packages.json 17:55:51 INFO - Downloading https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:55:52 INFO - Downloaded 989 bytes. 17:55:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:55:52 INFO - Using the following test package requirements: 17:55:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:55:52 INFO - u'common': [u'target.common.tests.zip'], 17:55:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:55:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:55:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:55:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:55:52 INFO - u'mozbase': [u'target.common.tests.zip'], 17:55:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:55:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:55:52 INFO - u'web-platform': [u'target.common.tests.zip', 17:55:52 INFO - u'target.web-platform.tests.tar.gz'], 17:55:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:55:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:55:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip 17:55:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:55:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip into memory 17:55:53 INFO - Content-Length response header: 54619852 17:55:53 INFO - Bytes received: 54619852 17:56:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:56:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip 17:56:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:04 INFO - Fetch https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.common.tests.zip into memory 17:56:05 INFO - Content-Length response header: 54619852 17:56:05 INFO - Bytes received: 54619852 17:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.talos.tests.zip 17:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.talos.tests.zip into memory 17:56:18 INFO - Content-Length response header: 14496256 17:56:18 INFO - Bytes received: 14496256 17:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:18 INFO - trying https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 17:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:56:20 INFO - Downloaded 63050164 bytes. 17:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 17:56:20 INFO - mkdir: /builds/slave/test/properties 17:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:20 INFO - Contents: 17:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - Running post-action listener: find_tests_for_verification 17:56:20 INFO - Running post-action listener: set_extra_try_arguments 17:56:20 INFO - [mozharness: 2017-08-22 00:56:20.032641Z] Finished download-and-extract step (success) 17:56:20 INFO - [mozharness: 2017-08-22 00:56:20.032738Z] Running populate-webroot step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running main action method: populate_webroot 17:56:20 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:20 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:20 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:20 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'tests': ['damp', 'tps']}, 17:56:20 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['damp', 'tps']}, 17:56:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:56:20 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:56:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:20 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:20 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_many_windows', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['a11yr', 17:56:20 INFO - 'ts_paint', 17:56:20 INFO - 'tpaint', 17:56:20 INFO - 'sessionrestore', 17:56:20 INFO - 'sessionrestore_many_windows', 17:56:20 INFO - 'sessionrestore_no_auto_restore', 17:56:20 INFO - 'tabpaint']}, 17:56:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:56:20 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:56:20 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['bloom_basic_singleton']}, 17:56:20 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['bloom_basic']}, 17:56:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:20 INFO - 'tsvgr_opacity', 17:56:20 INFO - 'tart', 17:56:20 INFO - 'tscrollx', 17:56:20 INFO - 'tsvg_static']}, 17:56:20 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['tsvgx', 17:56:20 INFO - 'tsvgr_opacity', 17:56:20 INFO - 'tart', 17:56:20 INFO - 'tscrollx', 17:56:20 INFO - 'tsvg_static']}, 17:56:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:56:20 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--stylo'], 17:56:20 INFO - 'tests': ['tp5o']}, 17:56:20 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:20 INFO - 'talos_options': ['--mitmproxy', 17:56:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:20 INFO - '--firstNonBlankPaint'], 17:56:20 INFO - 'tests': ['tp6_google', 17:56:20 INFO - 'tp6_youtube', 17:56:20 INFO - 'tp6_amazon', 17:56:20 INFO - 'tp6_facebook']}, 17:56:20 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:20 INFO - 'talos_options': ['--stylo', 17:56:20 INFO - '--mitmproxy', 17:56:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:20 INFO - '--firstNonBlankPaint'], 17:56:20 INFO - 'tests': ['tp6_google', 17:56:20 INFO - 'tp6_youtube', 17:56:20 INFO - 'tp6_amazon', 17:56:20 INFO - 'tp6_facebook']}, 17:56:20 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:20 INFO - 'talos_options': ['--stylo', 17:56:20 INFO - '--stylo-threads=1', 17:56:20 INFO - '--mitmproxy', 17:56:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:20 INFO - '--firstNonBlankPaint'], 17:56:20 INFO - 'tests': ['tp6_google', 17:56:20 INFO - 'tp6_youtube', 17:56:20 INFO - 'tp6_amazon', 17:56:20 INFO - 'tp6_facebook']}, 17:56:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--xperf_path', 17:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:20 INFO - 'tests': ['tp5n']}, 17:56:20 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:20 INFO - 'talos_options': ['--stylo', 17:56:20 INFO - '--xperf_path', 17:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:20 INFO - 'tests': ['tp5n']}}} 17:56:20 INFO - Running post-action listener: _resource_record_post_action 17:56:20 INFO - [mozharness: 2017-08-22 00:56:20.046958Z] Finished populate-webroot step (success) 17:56:20 INFO - [mozharness: 2017-08-22 00:56:20.047046Z] Running create-virtualenv step. 17:56:20 INFO - Running pre-action listener: _resource_record_pre_action 17:56:20 INFO - Running main action method: create_virtualenv 17:56:20 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:20 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 17:56:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:20 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:56:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:20 INFO - Using real prefix '/usr' 17:56:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:20 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:22 INFO - Installing pip.................done. 17:56:22 INFO - Return code: 0 17:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:56:22 INFO - Reading from file tmpfile_stdout 17:56:22 INFO - Output received: 17:56:22 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) 17:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:22 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')]} 17:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:22 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')]} 17:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:22 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:22 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 17:56:22 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 17:56:22 INFO - Using env: {'DISPLAY': ':0', 17:56:22 INFO - 'HOME': '/home/cltbld', 17:56:22 INFO - 'LANG': 'en_US.UTF-8', 17:56:22 INFO - 'LANGUAGE': 'en_US:en', 17:56:22 INFO - 'LOGNAME': 'cltbld', 17:56:22 INFO - 'MAIL': '/var/mail/cltbld', 17:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:22 INFO - 'MOZ_NO_REMOTE': '1', 17:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:22 INFO - 'NO_EM_RESTART': '1', 17:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:22 INFO - 'PWD': '/builds/slave/test', 17:56:22 INFO - 'SHELL': '/bin/bash', 17:56:22 INFO - 'SHLVL': '1', 17:56:22 INFO - 'TERM': 'linux', 17:56:22 INFO - 'TMOUT': '86400', 17:56:22 INFO - 'USER': 'cltbld', 17:56:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:22 INFO - '_': '/tools/buildbot/bin/python'} 17:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:23 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 17:56:23 INFO - Cleaning up... 17:56:23 INFO - Return code: 0 17:56:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:23 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:23 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 17:56:23 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 17:56:23 INFO - Using env: {'DISPLAY': ':0', 17:56:23 INFO - 'HOME': '/home/cltbld', 17:56:23 INFO - 'LANG': 'en_US.UTF-8', 17:56:23 INFO - 'LANGUAGE': 'en_US:en', 17:56:23 INFO - 'LOGNAME': 'cltbld', 17:56:23 INFO - 'MAIL': '/var/mail/cltbld', 17:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:23 INFO - 'MOZ_NO_REMOTE': '1', 17:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:23 INFO - 'NO_EM_RESTART': '1', 17:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:23 INFO - 'PWD': '/builds/slave/test', 17:56:23 INFO - 'SHELL': '/bin/bash', 17:56:23 INFO - 'SHLVL': '1', 17:56:23 INFO - 'TERM': 'linux', 17:56:23 INFO - 'TMOUT': '86400', 17:56:23 INFO - 'USER': 'cltbld', 17:56:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:23 INFO - '_': '/tools/buildbot/bin/python'} 17:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:23 INFO - Downloading/unpacking psutil>=3.1.1 17:56:23 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 17:56:23 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 17:56:23 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 17:56:23 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 17:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:24 INFO - Installing collected packages: psutil 17:56:24 INFO - Running setup.py install for psutil 17:56:24 INFO - building 'psutil._psutil_linux' extension 17:56:24 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 17:56:24 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 17:56:24 INFO - building 'psutil._psutil_posix' extension 17:56:24 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 17:56:24 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 17:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:24 INFO - Successfully installed psutil 17:56:24 INFO - Cleaning up... 17:56:25 INFO - Return code: 0 17:56:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:25 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:25 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 17:56:25 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 17:56:25 INFO - Using env: {'DISPLAY': ':0', 17:56:25 INFO - 'HOME': '/home/cltbld', 17:56:25 INFO - 'LANG': 'en_US.UTF-8', 17:56:25 INFO - 'LANGUAGE': 'en_US:en', 17:56:25 INFO - 'LOGNAME': 'cltbld', 17:56:25 INFO - 'MAIL': '/var/mail/cltbld', 17:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:25 INFO - 'MOZ_NO_REMOTE': '1', 17:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:25 INFO - 'NO_EM_RESTART': '1', 17:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:25 INFO - 'PWD': '/builds/slave/test', 17:56:25 INFO - 'SHELL': '/bin/bash', 17:56:25 INFO - 'SHLVL': '1', 17:56:25 INFO - 'TERM': 'linux', 17:56:25 INFO - 'TMOUT': '86400', 17:56:25 INFO - 'USER': 'cltbld', 17:56:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:25 INFO - '_': '/tools/buildbot/bin/python'} 17:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:25 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 17:56:25 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 17:56:25 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 17:56:25 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 17:56:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:26 INFO - Installing collected packages: mozsystemmonitor 17:56:26 INFO - Running setup.py install for mozsystemmonitor 17:56:26 INFO - Successfully installed mozsystemmonitor 17:56:26 INFO - Cleaning up... 17:56:26 INFO - Return code: 0 17:56:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:26 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')]} 17:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:26 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')]} 17:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:26 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:26 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 17:56:26 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 17:56:26 INFO - Using env: {'DISPLAY': ':0', 17:56:26 INFO - 'HOME': '/home/cltbld', 17:56:26 INFO - 'LANG': 'en_US.UTF-8', 17:56:26 INFO - 'LANGUAGE': 'en_US:en', 17:56:26 INFO - 'LOGNAME': 'cltbld', 17:56:26 INFO - 'MAIL': '/var/mail/cltbld', 17:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:26 INFO - 'MOZ_NO_REMOTE': '1', 17:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:26 INFO - 'NO_EM_RESTART': '1', 17:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:26 INFO - 'PWD': '/builds/slave/test', 17:56:26 INFO - 'SHELL': '/bin/bash', 17:56:26 INFO - 'SHLVL': '1', 17:56:26 INFO - 'TERM': 'linux', 17:56:26 INFO - 'TMOUT': '86400', 17:56:26 INFO - 'USER': 'cltbld', 17:56:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:26 INFO - '_': '/tools/buildbot/bin/python'} 17:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:26 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:27 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:28 INFO - warning: no files found matching '*.txt' 17:56:28 INFO - no previously-included directories found matching 'build' 17:56:28 INFO - no previously-included directories found matching 'dist' 17:56:28 INFO - no previously-included directories found matching '.git*' 17:56:28 INFO - Installing collected packages: jsonschema, functools32 17:56:28 INFO - Running setup.py install for functools32 17:56:28 INFO - warning: no files found matching '*.txt' 17:56:28 INFO - no previously-included directories found matching 'build' 17:56:28 INFO - no previously-included directories found matching 'dist' 17:56:28 INFO - no previously-included directories found matching '.git*' 17:56:28 INFO - Successfully installed jsonschema functools32 17:56:28 INFO - Cleaning up... 17:56:28 INFO - Return code: 0 17:56:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:28 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')]} 17:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:28 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')]} 17:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:28 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:28 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 17:56:28 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 17:56:28 INFO - Using env: {'DISPLAY': ':0', 17:56:28 INFO - 'HOME': '/home/cltbld', 17:56:28 INFO - 'LANG': 'en_US.UTF-8', 17:56:28 INFO - 'LANGUAGE': 'en_US:en', 17:56:28 INFO - 'LOGNAME': 'cltbld', 17:56:28 INFO - 'MAIL': '/var/mail/cltbld', 17:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:28 INFO - 'MOZ_NO_REMOTE': '1', 17:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:28 INFO - 'NO_EM_RESTART': '1', 17:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:28 INFO - 'PWD': '/builds/slave/test', 17:56:28 INFO - 'SHELL': '/bin/bash', 17:56:28 INFO - 'SHLVL': '1', 17:56:28 INFO - 'TERM': 'linux', 17:56:28 INFO - 'TMOUT': '86400', 17:56:28 INFO - 'USER': 'cltbld', 17:56:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:28 INFO - '_': '/tools/buildbot/bin/python'} 17:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:28 INFO - Cleaning up... 17:56:28 INFO - Return code: 0 17:56:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:28 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')]} 17:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:28 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')]} 17:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:28 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:28 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 17:56:28 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 17:56:28 INFO - Using env: {'DISPLAY': ':0', 17:56:28 INFO - 'HOME': '/home/cltbld', 17:56:28 INFO - 'LANG': 'en_US.UTF-8', 17:56:28 INFO - 'LANGUAGE': 'en_US:en', 17:56:28 INFO - 'LOGNAME': 'cltbld', 17:56:28 INFO - 'MAIL': '/var/mail/cltbld', 17:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:28 INFO - 'MOZ_NO_REMOTE': '1', 17:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:28 INFO - 'NO_EM_RESTART': '1', 17:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:28 INFO - 'PWD': '/builds/slave/test', 17:56:28 INFO - 'SHELL': '/bin/bash', 17:56:28 INFO - 'SHLVL': '1', 17:56:28 INFO - 'TERM': 'linux', 17:56:28 INFO - 'TMOUT': '86400', 17:56:28 INFO - 'USER': 'cltbld', 17:56:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:28 INFO - '_': '/tools/buildbot/bin/python'} 17:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:28 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 17:56:28 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 17:56:28 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 17:56:28 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 17:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:29 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 17:56:29 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 17:56:29 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 17:56:29 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 17:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:30 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 17:56:30 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 17:56:30 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 17:56:30 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 17:56:30 INFO - Downloading docopt-0.6.1.tar.gz 17:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:30 INFO - Running setup.py install for blobuploader 17:56:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:30 INFO - Running setup.py install for requests 17:56:30 INFO - Running setup.py install for docopt 17:56:30 INFO - Successfully installed blobuploader requests docopt 17:56:30 INFO - Cleaning up... 17:56:30 INFO - Return code: 0 17:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:30 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:30 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 17:56:30 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 17:56:30 INFO - Using env: {'DISPLAY': ':0', 17:56:30 INFO - 'HOME': '/home/cltbld', 17:56:30 INFO - 'LANG': 'en_US.UTF-8', 17:56:30 INFO - 'LANGUAGE': 'en_US:en', 17:56:30 INFO - 'LOGNAME': 'cltbld', 17:56:30 INFO - 'MAIL': '/var/mail/cltbld', 17:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:30 INFO - 'MOZ_NO_REMOTE': '1', 17:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:30 INFO - 'NO_EM_RESTART': '1', 17:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:30 INFO - 'PWD': '/builds/slave/test', 17:56:30 INFO - 'SHELL': '/bin/bash', 17:56:30 INFO - 'SHLVL': '1', 17:56:30 INFO - 'TERM': 'linux', 17:56:30 INFO - 'TMOUT': '86400', 17:56:30 INFO - 'USER': 'cltbld', 17:56:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:30 INFO - '_': '/tools/buildbot/bin/python'} 17:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:31 INFO - Running setup.py (path:/tmp/pip-8b3Fwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:31 INFO - Running setup.py (path:/tmp/pip-LllgKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:31 INFO - Running setup.py (path:/tmp/pip-T34vvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:31 INFO - Running setup.py (path:/tmp/pip-Hjibek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:31 INFO - Running setup.py (path:/tmp/pip-uJMdY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:31 INFO - Running setup.py (path:/tmp/pip-5CFJuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:31 INFO - Running setup.py (path:/tmp/pip-YmZXCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:31 INFO - Running setup.py (path:/tmp/pip-NVtG7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:31 INFO - Running setup.py (path:/tmp/pip-NmZQn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:31 INFO - Running setup.py (path:/tmp/pip-lVKb53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:31 INFO - Running setup.py (path:/tmp/pip-RjxsKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:31 INFO - Running setup.py (path:/tmp/pip-QZ6mop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:32 INFO - Running setup.py (path:/tmp/pip-ov2aSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:32 INFO - Running setup.py (path:/tmp/pip-_e32zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:32 INFO - Running setup.py (path:/tmp/pip-43ixuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:32 INFO - Running setup.py (path:/tmp/pip-2esY_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:32 INFO - Running setup.py (path:/tmp/pip-HNn4mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:32 INFO - Running setup.py install for manifestparser 17:56:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:32 INFO - Running setup.py install for mozcrash 17:56:32 INFO - Running setup.py install for mozdebug 17:56:32 INFO - Running setup.py install for mozdevice 17:56:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:32 INFO - Running setup.py install for mozfile 17:56:32 INFO - Running setup.py install for mozhttpd 17:56:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:32 INFO - Running setup.py install for mozinfo 17:56:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for mozInstall 17:56:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for mozleak 17:56:33 INFO - Running setup.py install for mozlog 17:56:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for moznetwork 17:56:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for mozprocess 17:56:33 INFO - Running setup.py install for mozprofile 17:56:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for mozrunner 17:56:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:33 INFO - Running setup.py install for mozscreenshot 17:56:33 INFO - Running setup.py install for moztest 17:56:34 INFO - Running setup.py install for mozversion 17:56:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:34 INFO - Cleaning up... 17:56:34 INFO - Return code: 0 17:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:34 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')]} 17:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:34 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')]} 17:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:34 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:34 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 17:56:34 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 17:56:34 INFO - Using env: {'DISPLAY': ':0', 17:56:34 INFO - 'HOME': '/home/cltbld', 17:56:34 INFO - 'LANG': 'en_US.UTF-8', 17:56:34 INFO - 'LANGUAGE': 'en_US:en', 17:56:34 INFO - 'LOGNAME': 'cltbld', 17:56:34 INFO - 'MAIL': '/var/mail/cltbld', 17:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:34 INFO - 'MOZ_NO_REMOTE': '1', 17:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:34 INFO - 'NO_EM_RESTART': '1', 17:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:34 INFO - 'PWD': '/builds/slave/test', 17:56:34 INFO - 'SHELL': '/bin/bash', 17:56:34 INFO - 'SHLVL': '1', 17:56:34 INFO - 'TERM': 'linux', 17:56:34 INFO - 'TMOUT': '86400', 17:56:34 INFO - 'USER': 'cltbld', 17:56:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:34 INFO - '_': '/tools/buildbot/bin/python'} 17:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:34 INFO - Running setup.py (path:/tmp/pip-S55bjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:34 INFO - Running setup.py (path:/tmp/pip-BdRwes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:34 INFO - Running setup.py (path:/tmp/pip-gbMEdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:34 INFO - Running setup.py (path:/tmp/pip-7cYLb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:34 INFO - Running setup.py (path:/tmp/pip-abwnrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:34 INFO - Running setup.py (path:/tmp/pip-nBoV6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:34 INFO - Running setup.py (path:/tmp/pip-KNPGei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:34 INFO - Running setup.py (path:/tmp/pip-_wwLvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:34 INFO - Running setup.py (path:/tmp/pip-qmJyip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:34 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)) 17:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:34 INFO - Running setup.py (path:/tmp/pip-RxJJ1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:35 INFO - Running setup.py (path:/tmp/pip-QKf2Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:35 INFO - Running setup.py (path:/tmp/pip-wqxO9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:35 INFO - Running setup.py (path:/tmp/pip-UJhrbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:35 INFO - Running setup.py (path:/tmp/pip-1jmjlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:35 INFO - Running setup.py (path:/tmp/pip-sBNnTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:35 INFO - Running setup.py (path:/tmp/pip-5NLHiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:35 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)) 17:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:35 INFO - Running setup.py (path:/tmp/pip-vmTkWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:35 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)) 17:56:35 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)) 17:56:35 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)) 17:56:35 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)) 17:56:35 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)) 17:56:35 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)) 17:56:35 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)) 17:56:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:35 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 17:56:35 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 17:56:35 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 17:56:35 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 17:56:36 INFO - Downloading blessings-1.6.tar.gz 17:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:36 INFO - Installing collected packages: blessings 17:56:36 INFO - Running setup.py install for blessings 17:56:36 INFO - Successfully installed blessings 17:56:36 INFO - Cleaning up... 17:56:36 INFO - Return code: 0 17:56:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:37 INFO - Reading from file tmpfile_stdout 17:56:37 INFO - Current package versions: 17:56:37 INFO - argparse == 1.2.1 17:56:37 INFO - blessings == 1.6 17:56:37 INFO - blobuploader == 1.2.4 17:56:37 INFO - docopt == 0.6.1 17:56:37 INFO - functools32 == 3.2.3-2 17:56:37 INFO - jsonschema == 2.5.1 17:56:37 INFO - manifestparser == 1.1 17:56:37 INFO - mozInstall == 1.13 17:56:37 INFO - mozcrash == 1.0 17:56:37 INFO - mozdebug == 0.1 17:56:37 INFO - mozdevice == 0.51 17:56:37 INFO - mozfile == 1.2 17:56:37 INFO - mozhttpd == 0.7 17:56:37 INFO - mozinfo == 0.10 17:56:37 INFO - mozleak == 0.1 17:56:37 INFO - mozlog == 3.5 17:56:37 INFO - moznetwork == 0.27 17:56:37 INFO - mozprocess == 0.25 17:56:37 INFO - mozprofile == 0.28 17:56:37 INFO - mozrunner == 6.13 17:56:37 INFO - mozscreenshot == 0.1 17:56:37 INFO - mozsystemmonitor == 0.3 17:56:37 INFO - moztest == 0.8 17:56:37 INFO - mozversion == 1.4 17:56:37 INFO - psutil == 3.1.1 17:56:37 INFO - requests == 1.2.3 17:56:37 INFO - wsgiref == 0.1.2 17:56:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:37 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:37 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 17:56:37 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 17:56:37 INFO - Using env: {'DISPLAY': ':0', 17:56:37 INFO - 'HOME': '/home/cltbld', 17:56:37 INFO - 'LANG': 'en_US.UTF-8', 17:56:37 INFO - 'LANGUAGE': 'en_US:en', 17:56:37 INFO - 'LOGNAME': 'cltbld', 17:56:37 INFO - 'MAIL': '/var/mail/cltbld', 17:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:37 INFO - 'MOZ_NO_REMOTE': '1', 17:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:37 INFO - 'NO_EM_RESTART': '1', 17:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:37 INFO - 'PWD': '/builds/slave/test', 17:56:37 INFO - 'SHELL': '/bin/bash', 17:56:37 INFO - 'SHLVL': '1', 17:56:37 INFO - 'TERM': 'linux', 17:56:37 INFO - 'TMOUT': '86400', 17:56:37 INFO - 'USER': 'cltbld', 17:56:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:37 INFO - '_': '/tools/buildbot/bin/python'} 17:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 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)) 17:56:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:56:37 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 17:56:37 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 17:56:37 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 17:56:37 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 17:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:56:38 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)) 17:56:38 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)) 17:56:38 INFO - Installing collected packages: simplejson 17:56:38 INFO - Running setup.py install for simplejson 17:56:38 INFO - building 'simplejson._speedups' extension 17:56:38 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 17:56:39 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 17:56:39 INFO - Successfully installed simplejson 17:56:39 INFO - Cleaning up... 17:56:39 INFO - Return code: 0 17:56:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56: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')]} 17:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:39 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 0xf3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1106a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', '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 17:56:39 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 17:56:39 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 17:56:39 INFO - Using env: {'DISPLAY': ':0', 17:56:39 INFO - 'HOME': '/home/cltbld', 17:56:39 INFO - 'LANG': 'en_US.UTF-8', 17:56:39 INFO - 'LANGUAGE': 'en_US:en', 17:56:39 INFO - 'LOGNAME': 'cltbld', 17:56:39 INFO - 'MAIL': '/var/mail/cltbld', 17:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:39 INFO - 'MOZ_NO_REMOTE': '1', 17:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:39 INFO - 'NO_EM_RESTART': '1', 17:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:39 INFO - 'PWD': '/builds/slave/test', 17:56:39 INFO - 'SHELL': '/bin/bash', 17:56:39 INFO - 'SHLVL': '1', 17:56:39 INFO - 'TERM': 'linux', 17:56:39 INFO - 'TMOUT': '86400', 17:56:39 INFO - 'USER': 'cltbld', 17:56:39 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:39 INFO - '_': '/tools/buildbot/bin/python'} 17:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:39 INFO - Cleaning up... 17:56:39 INFO - Return code: 0 17:56:39 INFO - Running post-action listener: _resource_record_post_action 17:56:39 INFO - Running post-action listener: _start_resource_monitoring 17:56:39 INFO - Starting resource monitoring. 17:56:39 INFO - [mozharness: 2017-08-22 00:56:39.839045Z] Finished create-virtualenv step (success) 17:56:39 INFO - [mozharness: 2017-08-22 00:56:39.839510Z] Running install step. 17:56:39 INFO - Running pre-action listener: _resource_record_pre_action 17:56:39 INFO - Running main action method: install 17:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:40 INFO - Reading from file tmpfile_stdout 17:56:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:40 INFO - Reading from file tmpfile_stdout 17:56:40 INFO - Output received: 17:56:40 INFO - Usage: mozinstall [options] installer 17:56:40 INFO - Options: 17:56:40 INFO - -h, --help show this help message and exit 17:56:40 INFO - -d DEST, --destination=DEST 17:56:40 INFO - Directory to install application into. [default: 17:56:40 INFO - "/builds/slave/test"] 17:56:40 INFO - --app=APP Application being installed. [default: firefox] 17:56:40 INFO - mkdir: /builds/slave/test/build/application 17:56:40 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'] 17:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:56:58 INFO - Reading from file tmpfile_stdout 17:56:58 INFO - Output received: 17:56:58 INFO - /builds/slave/test/build/application/firefox/firefox 17:56:58 INFO - Running post-action listener: _resource_record_post_action 17:56:58 INFO - [mozharness: 2017-08-22 00:56:58.968910Z] Finished install step (success) 17:56:58 INFO - [mozharness: 2017-08-22 00:56:58.969191Z] Running setup-mitmproxy step. 17:56:58 INFO - Running pre-action listener: _resource_record_pre_action 17:56:58 INFO - Running main action method: setup_mitmproxy 17:56:58 INFO - Skipping: mitmproxy is not required 17:56:58 INFO - Running post-action listener: _resource_record_post_action 17:56:58 INFO - [mozharness: 2017-08-22 00:56:58.970428Z] Finished setup-mitmproxy step (success) 17:56:58 INFO - [mozharness: 2017-08-22 00:56:58.970648Z] Running run-tests step. 17:56:58 INFO - Running pre-action listener: _resource_record_pre_action 17:56:58 INFO - Running pre-action listener: _set_gcov_prefix 17:56:58 INFO - Running main action method: run_tests 17:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:56:58 INFO - Python 2.7.3 17:56:58 INFO - Return code: 0 17:56:58 INFO - grabbing minidump binary from tooltool 17:56: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')]} 17:56:58 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 0x12a7130>, '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 0x12a8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a84c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:56:58 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 17:56:58 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 17:56:58 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 17:56:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:59 INFO - Return code: 0 17:56:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:56:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:56:59 INFO - ENV: RUST_BACKTRACE is now full 17:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:56:59 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/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:56:59 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/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 17:56:59 INFO - Using env: {'DISPLAY': ':0', 17:56:59 INFO - 'HOME': '/home/cltbld', 17:56:59 INFO - 'LANG': 'en_US.UTF-8', 17:56:59 INFO - 'LANGUAGE': 'en_US:en', 17:56:59 INFO - 'LOGNAME': 'cltbld', 17:56:59 INFO - 'MAIL': '/var/mail/cltbld', 17:56:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:56:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:59 INFO - 'MOZ_NO_REMOTE': '1', 17:56:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:59 INFO - 'NO_EM_RESTART': '1', 17:56:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:59 INFO - 'PWD': '/builds/slave/test', 17:56:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:56:59 INFO - 'RUST_BACKTRACE': 'full', 17:56:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:56:59 INFO - 'SHELL': '/bin/bash', 17:56:59 INFO - 'SHLVL': '1', 17:56:59 INFO - 'TERM': 'linux', 17:56:59 INFO - 'TMOUT': '86400', 17:56:59 INFO - 'USER': 'cltbld', 17:56:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673', 17:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:59 INFO - '_': '/tools/buildbot/bin/python'} 17:56:59 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/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 17:56:59 INFO - mozversion application_buildid: 20170821234030 17:56:59 INFO - mozversion application_changeset: 128a79130ecd6f277190d031a623f991c73c5272 17:56:59 INFO - mozversion application_display_name: Nightly 17:56:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:59 INFO - mozversion application_name: Firefox 17:56:59 INFO - mozversion application_remotingname: firefox 17:56:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:56:59 INFO - mozversion application_vendor: Mozilla 17:56:59 INFO - mozversion application_version: 57.0a1 17:56:59 INFO - mozversion platform_buildid: 20170821234030 17:56:59 INFO - mozversion platform_changeset: 128a79130ecd6f277190d031a623f991c73c5272 17:56:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:56:59 INFO - mozversion platform_version: 57.0a1 17:56:59 INFO - using testdate: 1503363419 17:56:59 INFO - actual date: 1503363419 17:56:59 INFO - starting webserver on 'localhost:60211' 17:56:59 INFO - SUITE-START | Running 2 tests 17:56:59 INFO - TEST-START | dromaeo_css 17:56:59 INFO - Initialising browser for dromaeo_css test... 17:56:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60211/getInfo.html -profile /tmp/tmpirygb5/profile 17:56:59 INFO - TEST-INFO | started process 27209 (/builds/slave/test/build/application/firefox/firefox http://localhost:60211/getInfo.html) 17:57:06 INFO - TEST-INFO | 27209: exit 0 17:57:06 INFO - Browser initialized. 17:57:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:06 INFO - TEST-INFO | started process 27384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpirygb5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:07 INFO - PID 27384 | 17:57:07 INFO - PID 27384 | (/builds/slave/test/build/application/firefox/firefox:27433): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:07 INFO - PID 27384 | 17:57:08 INFO - PID 27384 | 17:57:08 INFO - PID 27384 | (/builds/slave/test/build/application/firefox/firefox:27490): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:08 INFO - PID 27384 | 17:57:08 INFO - PID 27384 | __metrics Screen width/height:1600/1200 17:57:08 INFO - PID 27384 | colorDepth:24 17:57:08 INFO - PID 27384 | Browser inner width/height: 1024/768 17:57:08 INFO - PID 27384 | __metrics 17:57:18 INFO - PID 27384 | RSS: Main: 165486592 17:57:18 INFO - PID 27384 | 18:00:16 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60211/tests/dromaeo/cssquery-ext.html) 18:00:17 INFO - PID 27384 | RSS: Main: 170799104 18:00:17 INFO - PID 27384 | 18:03:19 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-ext.html (next: http://localhost:60211/tests/dromaeo/cssquery-jquery.html) 18:03:19 INFO - PID 27384 | RSS: Main: 167063552 18:03:19 INFO - PID 27384 | 18:06:21 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60211/tests/dromaeo/cssquery-mootools.html) 18:06:21 INFO - PID 27384 | RSS: Main: 167534592 18:06:21 INFO - PID 27384 | 18:09:23 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60211/tests/dromaeo/cssquery-prototype.html) 18:09:23 INFO - PID 27384 | RSS: Main: 167862272 18:09:23 INFO - PID 27384 | 18:12:27 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60211/tests/dromaeo/cssquery-yui.html) 18:12:27 INFO - PID 27384 | RSS: Main: 170938368 18:12:27 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:60211/tests/dromaeo/cssquery-yui.html (next: http://localhost:60211/tests/dromaeo/cssquery-dojo.html) 18:15:29 INFO - PID 27384 | RSS: Main: 171417600 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | __start_tp_report 18:15:29 INFO - PID 27384 | _x_x_mozilla_page_load 18:15:29 INFO - PID 27384 | _x_x_mozilla_page_load_details 18:15:29 INFO - PID 27384 | |i|pagename|runs| 18:15:29 INFO - PID 27384 | |0;dojo.html;3483.7038851697603;3494.4583589543613;3529.4705794130878;3530.258645684406;3546.503489511469;6150.507959363252;6234.470070044046;6240.063990401436;6252.562320637558;6300.0234963580715;6110.236220472441;6154.753809847612;6180.907286390708;6183.196184496021;6210.565260431772;5410.56715462764;5416.350037995437;5430.864228394283;5435.157550579646;5441.29263195784;5449.209864569635;5471.671699698031;5528.75120619571;5559.777608895639;5614.747336369853;5532.059549876531;5570.053090974544;5579.079451890433;5591.4688104629995;5608.2428872102155;5338.786448542053;5436.3476382833915;5489.094299440588;5504.80733174341;5595.804146854861;5257.421683614799;5409.9459005409835;5435.402105768362;5479.945200547983;5513.338399392059;6115.419020366642;6147.969260153715;6159.81520554384;6223.7821676241565;6237;6543.770968016097;6690.83272918181;6744.696488658022;6823;6829;6719.496037797136;6736.090627765238;6766.49251306154;6768.39084482394;6777.593344399352;6255.186825712673;6338.968305158491;6346;6355.078513615546;6373.74505019794;6857.828554286083;6927.515073944775;7015.403690686247;7017.017617533549;7031.015657807911;6653.667316634149;6680.265170831205;6723.394894459424;6748.763793267212;6752.22349429812;6449.96775016122;6616.172978377703;6676.899846502306;6782.864342713118;6818.215905170969;6730.9326906731285;6736.360045795642;6751.223609284897;6773.288804675537;6800.251972283045;6736.562123461959;6744.460443164535;6816.556923799937;6818.829529261709;6825.522213445011;4848.345473361122;4894.804207831647;4912.729799861042;4912.95087049125;4916.115099282092;4286.421333120051;4331.5884990925815;4339.088791353851;4401.075774087413;4418.955810441918;6501.382368674968;6526.477881769447;6556.27880933097;6563.3764792344655;6584.407403333723;6794.048833163361;6800.6939687714175;6805.353491418307;6878.931210687929;6885.862282754317;6465.870682586322;6477.935220647827;6485.7405703772265;6502.284748677642;6550.934490655128;5349.170878513836;5412.7293635318865;5426.375966763794;5430.8099216527235;5432.619716619878;7087.751928682472;7099.148102227766;7152.92847071533;7169.318914703095;7172.426205903515;6526.967365163144;6643.534952553275;6771.28901465339;6850.588964662136;6855.520113592001;7179.964100179465;7239.8914016288745;7242.710291588278;7250.129984401906;7251.383632391306;6642.070110184482;6683.732650693918;6762.966185169043;6769.89845152333;6771.052052712525;6674.799756007327;6782.491313151435;6788.2193547742645;6801.727930882709;6885.793426197222;6630;6690.6320152390135;6694.230163531061;6696;6703.899441508479;6534.934650653623;6592.67036648156;6663.333666633298;6699.263081061177;6706.899396509154;6550.213974323112;6575.671216439063;6589.143411356493;6647.966760166169;6674.065630811593;6667.933320666732;6698.83252918681;6738.49461290415;6749.122614060141;6755.121834161528;6228.408301211378;6368.522360822864;6441.484681225585;6526.543141980016;6534.150560427114 18:15:29 INFO - PID 27384 | |1;ext.html;904.1275169461468;915.5422288855572;940.877685900833;964.1081999150783;966.5022513405597;35412.93761187162;36503.45244821326;44435;45191.77404112983;45238.32142517865;45311.09377812442;45419.772901135446;45430.54569454313;45641.77179114108;45667.314990275176;7822.687092516292;7825.45221834469;7942.801429964239;7944.880826787603;7947;7736.110347310075;7793.844123117534;7828.217178282155;7854.7250846220395;7866.646000929972;7863.449558530905;7916.643751031189;7917.406194535404;7919.445638805286;7921.801954951115;7857.292843644071;7875.763727088197;7877.724279650185;7877.7636670899965;7878.527288362717;7446.925530744677;7496.962515187389;7498.250174982512;7503.21216272289;7511.136219334791;40163.39754903679;40288.79855600703;40357;40411.191776164604;40469.595304046874;3545.2377738786286;3545.840437180333;3572;3584.068142282999;3585.8924232273075;31834.522482162785;31836;31895.52156717651;31922.521162182355;31954.201144971328;5212.452692467312;5227.242049902781;5247.658902171384;5271.393789714193;5279.234510995884;209272;209567;210138;210726;210741.9462902691;51177.48822511802;51246.48753512417;51411.742941285804;51414.22878656823;51421.48578514167;53755.43078838264;53817;53822.19266711002;54003.18995215075;54031.72984135054;14307.642308942151;14572.344244509022;16832.831671683372;17138.40015599448;17169;13836.86163138376;13989.160650361011;14020.228887411085;14046;14052.508162214273;15574.831887608474;15674.294656740474;15696.979696319702;15714.449994250146;15731.370745170065;5986;6072.696365181723;6238.157848690459;6269.185005949197;6285.277193122758;1083.7019819549687;1086.8804431512526;1091.24158709696;1101.4823033174396;1107.2470719910539;24072.762812777568;24126.311158218756;24203.757962420503;24350.51298974046;24496.164218313224;1186.9436201780422;1201.9399030048462;1204.6928033351614;1210.7639010393066;1219.6402061391912;13022.544210952572;13037.696230377076;13216.73566528664;13296;13358.198508089547;268185;269067;269504;270013;270584;56379.43620563824;56579.71710141505;56708;56854.715726421106;56880.43119568834;1551.0771091200718;1561.0789634115927;1578.0531680991544;1582.37496189007;1609.8953568018276;23349.182778603346;23475.882620586788;23579.41051473727;23686.170984015476;23746.406339840953;40190.397144042276;40204.597954020086;40289;40291.395629065;40308;232994;233304;233460;234526;234555;36505.63494365128;38474.807625961694;38605.613943861325;38968;39273.410898837115;47857;48948.5105148944;49065;49755;50138.247926280404;36539.26921461503;36990.63009369872;37028.81485592555;37301.440478393386;37366;36012.09969750777;36237.45643815292;36476.27047459089;36812.26375472529;37200.25599487941;41636.79181604073;42065.57934420617;42166.789166053975;42294.78852605717;42327.78836105923;35733.64266357303;35738;35872.4619130708;36110.27779444344;36740.81629591835;25911.22266332013;25984.35039124037;26083.478330433663;26592;26786.19641410761 18:15:29 INFO - PID 27384 | |2;jquery.html;567.2229046206696;568.6019786149697;572.9828105156844;574.2161948939696;588.9146073819296;23276.534469310605;23726.76273237267;24550.386240344;24585.631215531783;24593.754062459393;26489.735102648967;26867.86566067172;27050.05324813632;27067.593986090225;27068;6302.621842689442;6456.838579035515;6457.612543247396;6461.450776683988;6461.483081353504;5646.520045796112;6115.877682446348;6180.443760061594;6183.690815459209;6191.969040154793;6069.21100256966;6096.72564734588;6134.325224225332;6155.415235552616;6156.7537298508005;6119.571629985903;6140.324564297924;6141.477974372184;6144.201253837017;6147.0164773636225;5653.830385088454;5736.225609542742;5749.482546570829;5750.453706897838;5756.827295181151;30316.69683303161;30836.53745193824;30989.210971012493;31112.688873111205;31436.21409464759;2198.4613769626385;2227.7772222777594;2235.9552808943895;2236.0720301075035;2237.272886311955;20237.291694790612;20445.79554204454;21670.78329216719;21672.89163554172;21712.674309885366;2464.2730394533655;2501.524710305036;2542.631318458813;2542.8855701493476;2552.2598446450506;160899.19550402174;162692.18653906655;169264.99999999878;169631;169723;15243.618909527351;15343;15408.61478463025;15793.921030394775;15891;23280.7671923282;23429.531409371717;23436.64845027326;23440.765592343858;23483;10656.04095631397;10811.513481893333;10879.728006799893;10882.347059176474;10931.726706832234;10026.398416095057;10042.196624270187;10089.445080520494;10131.594736210616;10135.34120282194;9713.660021899199;9803.901960980442;9818.361806482555;9893.466512690544;9934;2789.9442011159663;2791.7487426131747;2791.930201744932;2813.212300555848;2943.411317736461;1030.6598822388594;1042.135027926819;1042.312074031151;1042.3433237060603;1057.6826951914395;20539.827519011833;20666;20712.689309660367;21272.574548509252;21356.14575416997;1097.6432659385732;1117.8267368557886;1122.259308856151;1131.3833960491552;1131.4851742457163;11473.254238474472;11578.189526733217;11587.304761714324;11601.245919015237;11751.764964700658;548218;559807;566590;579386;587371;132830;138040;138092;138285;138658.30670846583;1194.3073017649915;1270.1743866486856;1283.813846992181;1300.6163181861373;1314.1195399082828;22729.659055113854;22818.31545053651;22835.88582057079;22871.771282286965;22889.88555057214;63474.36525634684;65693;65925.34074659384;66684.33315666781;68427.65786171037;83769.58115209629;83776.58111709403;83858.58070709607;83971;84349;14410.639734006314;14845.480408185662;14849.331780069706;14873.256337183315;14881.702365952404;23842.64236036426;24119.638205427284;24274;24337.39156521101;24337.634935475628;19528.9023554887;19608.11763470619;19810.60378792445;19819;20115.19539218415;17597.560060998065;17637.382691605733;18013;18119.818801811813;18145.81854181494;19367.3221437249;19918;19972.10125544325;20013.59972800565;20119.295824646066;14599.416023358946;14718.852811471748;14731.116133032052;14736.115833050051;14743.11541307525;19299.710504342165;19357.225710971405;19626;19654.312099076462;19807.405777826687 18:15:29 INFO - PID 27384 | |3;mootools.html;1431.9212443315616;1486.5986183730392;1486.8810495160387;1500.047469856641;1501.1218437214236;15557;15834.920825395857;16094.517164485054;16139.515814525568;16158.676826463477;16451.506454806346;16656.08391538465;16660.250288737006;16664.83335166648;16678.916605416955;2470.4935488224914;2478.62820576914;2479.5412848622973;2481.1192026830486;2534.974650253492;2559.8720063996725;2615.372310645441;2642.180923913593;2643.74884385984;2678.129607877438;2406.2540612410207;2406.3743426709007;2429.2833614083797;2431.4286142756437;2432.3675844280524;2592.1575487966297;2609.8695065246757;2621.8164728469014;2622.711501734808;2630.4213073123883;2601.50571391435;2612.020492315382;2614.058938782037;2616;2619.345163709073;15452.227388630636;15768.448104316409;15771;15775.211239438097;15778.447754328543;8120.837583248302;8184.7953801155445;8529.23236908675;8537.871931921027;8549.743507694717;5337.092694241988;5342.252084708144;5441.129419292894;5457.208704737831;5488.56091512678;1856.5080253732772;1880.6614809334314;1880.9153588088568;1931.0730849192325;1968.468513501361;28297.15108546747;28298.717012829813;28457.715422845922;28490;28517.572236416472;6735.225449073419;6761.188657361148;6824.897626535606;6929.722811087601;6960.965195173992;18781.530461738566;18806.435806925812;18823.90588047051;18831;18832.34086806955;8201.671933122609;8322.8335433291;8334.833303333899;8367.163283671705;8369.163083691583;7526.774196773996;7592.772216833504;7791.883121753178;7791.961040194763;7793.454458187985;4953.578945789576;5180.171172612364;5386.973065134649;5413.2150838128255;5448.972755136199;1348.7639663058926;1518.9696206076037;1527.6257316957194;1552.6351307442742;1566.34996476461;923.4690053219425;926.8656044873455;934.9111834375724;938.1978408460805;945.3240932733129;8993;9203.861942070875;9262.305327100494;9299.20956718673;9468.005859384803;1012.1245122968579;1017.0744622393586;1031.5409642708923;1031.654395777423;1032.3238278927315;5013.24801279811;6173.135760993465;6257.937420625735;6298.370162983757;6346.841328966812;24005.879970600035;24240.636390454158;24285.7571424287;24365.512689746105;24382.512349752906;23386.532269354517;23642.52714945726;23905.28284151478;23956.88021559881;24160.516789664107;12807.871921280854;12979.41592628334;13068.085234033717;13070.869291307155;13105.67235819093;9327.626894924128;9891.159251463418;9909.30634855582;9919.603215871284;10020.448875311928;19896.403107906786;20130.194792208735;20331.390058298275;20735.585288294453;20833;20834.89582552138;21159.153633854472;21189.258375956768;21201.57596848085;21429.678554822003;13134.868651313365;13148.474061037452;13219.603411897659;13251.337433128112;13354.265515396746;14625.0493717908;14818.777718334019;14820.555383338517;14820.777688334469;14852.7772083421;11392.601258955896;11974.521019159485;12148.93925530402;12191.51233950632;12355.876441235832;10918.181136414642;11124.4981927442;11298.943505282421;11425;11444.084473242287;10391.636292729718;10399.064084232456;10461.110805581611;10521;10531.315464494783;8063.19368063189;8275.213854683796;8299.336053115858;8393.706220282262;8408.327333813402;7974.800629984296;7981.082175549654;7989.800254993672;8011.6394762237005;8042.115367309708 18:15:29 INFO - PID 27384 | |4;prototype.html;507.2847285327689;509.98470045898625;529.1744877990335;529.9735013249336;531.4658767938222;6055.5761096723245;6084.8478788030325;6109.14471973924;6121.602095863777;6176.814695559135;5852.414758524145;5903.911441328372;5907.202527658765;5961.61249518781;6016.669083200422;4737.242041273397;4740.857774266778;4781.211100168477;4792.586187074804;4804.519548045185;4654.534546545336;4754.548317909793;4762.595034464841;4765.761711914408;4824.252240902666;4716.900979064318;4748.35897153885;4756.381670382845;4772.952270477303;4783.665143439943;4749.097671442432;4759.785809638574;4781.708938586562;4788.473267940523;4795.832145874878;4320.287152619845;4329.9134017319475;4331.805068771881;4359.455068116486;4363.607275345203;6024.698765061729;6055.303640081403;6078.118672792464;6093.6039157454625;6113.388661133896;5777.162311464856;5777.826665200051;5782.97108514459;5791.21818554494;5795.1017592273265;6493.870122597569;6525.57583757059;6560.278369379364;6560.621280040783;6566.474682025427;4921.163402221595;4921.18800397934;4924.162892308281;4925.827596034157;4931.137051016058;6870.62211578363;6914.720776656334;6931.896021559681;6950.930490695129;6951.374376306107;5067.771950262247;5069.417017043087;5076.898462030738;5083.466236045236;5085.771140298695;5167.896642067138;5174;5184.844454666366;5189.974050129801;5201.713905735145;5666.235058267163;5720.513756330675;5732.398098199712;5759.136129580513;5789.913151302734;6509.251436084816;6548.738050478023;6548.934510654928;6551.6069035858;6573.835654108686;1692.5514738594281;1703.3782669325608;1704.0712811517753;1762.418401927361;1786.0355408079492;1232.1805999010737;1242.9875701242872;1244.6452760963264;1258.0501721200435;1268.587708994562;6185.567010309235;6235.127082208494;6274.968625156845;6281.8743625127245;6313.747450101944;6539.771108011292;6704.195496540447;6704.530682852153;6704.96647516769;6712.160979877515;6298.086777417248;6370.55406121567;6379.138816259746;6398.200224971879;6438.645874476949;3502.176988407722;3560.0209942266083;3574.392353299945;3576.123849656851;3598.208394153334;7073.221945585981;7140.9642951785945;7149.89275160873;7158.923912065443;7161.749338773118;6883.174019117738;6920.788861949139;6936.918924322683;6945.930540694529;6950.756723514653;7097.9290207097265;7131.786046418616;7138.965394862543;7192;7195.2444993276;6668;6670.466362690876;6764.289749576224;6778.610694652673;6834.897476537955;6657.933420665731;6678.298778628174;6706.295838937037;6708.563943343667;6711.295313991961;7119;7123.180834203926;7169.354758071799;7186.065811444479;7187.892181617175;5418.322709661293;5457.154141108134;5461.590380721383;5472.288602481652;5492.917606235989;6458.967705161444;6615.702293396713;6722.193336799615;6782.423494002867;6793;6334.144890439732;6410.391012853772;6412.551121421456;6427.58220715652;6567.2447668518735;6354.301026886947;6388.520860935541;6410.391012853772;6415.679216039272;6494.318096599978;6393.360663933756;6408.198975128109;6410.935890641033;6416.967915160394;6522.608643481406;6298.622082675054;6415.743370265323;6433.228012638326;6504.447121994684;6528.083150109896;6274.341194174546;6295.331737089767;6328.114064030948;6361.2048493938255;6418.903716444163 18:15:29 INFO - PID 27384 | |5;yui.html;930.1163894300416;931.1107891963175;956.837337652599;958.0754571838177;958.6932181701858;18721.25114995402;19378.321758738446;20018.49953751157;20043.899780501095;20088.69866951997;20406.387808365773;20808.68786968193;20844.062017209224;20915.37253882382;21005.894970525165;1023.7901230247782;1038.3458421194637;1046.5813674530173;1048.3081166430159;1050.1336397472078;1100.8073587122262;1107.058999850125;1107.070061148635;1107.595727559439;1110.4614262082923;1087.3801932898252;1131.383396049151;1138.4706111658077;1141.6689160143549;1177.6584790410814;1106.1869525898458;1112.6995711158022;1119.9328040317607;1120.2158489057651;1121.103117505992;811.6185392865344;811.9675212991532;812.1107387410776;815.4332738746574;826.8594338962331;20013.79986200134;20307.086181121886;20598.691019634716;20648.587028259502;20935;22481.887590562106;22686;22915.541689166123;23049.19327823518;23131.727754973468;17029.403970861084;17052;17283.308667653404;17380;17557.473275801618;3765.359888818907;3791.052236940765;3791.241751649681;3791.6018818023986;3792.981035094807;147798;148465;148733;148772.2561387197;149359;17328.133593320283;17491;17744.3789467368;17917.10414479271;17932.731009034876;32969.17577060593;33184.1703957403;33316.50025249623;33330.16674583155;33916.49125263123;8387.706430274911;8723.171298726611;8923.598438070303;9186.40288381253;9296.8605470918;3835.3096442640035;3929.7838618875667;3933.4296527004;3945.2109578084496;3950.802459876995;5444.564434845203;5450.754716037709;5511.3937466878615;5555.2222688823595;5560.277163968658;1108.8724796648328;1128.6952522818792;1142.1319796954208;1147.363213416545;1151.3379806611233;677.5900580149038;691.0843132848995;695.9478039147084;702.4380495603599;711.6157275071507;13127.081104322606;13320.866791331962;14940.626484337978;15071.698566028617;15235.061511423515;693.6774399904069;696.3245651717926;703.8064532253671;720.4056653261081;721.3327671903469;5992.460678538865;6096;6165.32181460039;6172.629642221481;6200.286966998763;142202;142918;144189.27905360406;145630;145759.2712036433;127386;128348.35825820811;129335.35332323467;130060;132197.33901330433;111585.44207279074;112408.43795780969;112702;113675.99999999834;114111.42944285391;11910.880891191324;12206.816897746363;12305.138640295094;12386;12546.623601291976;52352.21471678004;53126.20310695266;53861.73069134629;54329.18506222331;54405.72797135989;67723;68978.65510672414;68997;70687;93089.5345523268;20891.16435342569;20933.581328373042;20945.790542094383;20973.265935692176;21137.78862211358;23663.171788987303;23676.408089797893;23893.283201503982;23943.28170154898;24053.158139465733;22032.228871989402;22327;22644.320670379915;22699.205527806447;22707.88646056759;19450;19734.506637334183;19794.109265083393;19819.60360792805;19994.300199492947;20650.896745516777;20944.685829712264;21042.68435973431;21146.682799758324;21460.678089828976;14868.776968345699;15093.39626414931;15156.317965691791;15248.77126843076;15484.225788710293;15205.847941520444;15377.077375357514;15730.370785168923;16343.67312653764;16546.172691365144 18:15:29 INFO - PID 27384 | __end_tp_report 18:15:29 INFO - PID 27384 | __start_cc_report 18:15:29 INFO - PID 27384 | _x_x_mozilla_cycle_collect,352 18:15:29 INFO - PID 27384 | __end_cc_report 18:15:29 INFO - PID 27384 | __startTimestamp1503364529720__endTimestamp 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | ------- Summary: start ------- 18:15:29 INFO - PID 27384 | Number of tests: 6 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#0] dojo.html Cycles:165 Average:6225.74 Median:6556.28 stddev:824.60 (12.6%) stddev-sans-first:798.57 18:15:29 INFO - PID 27384 | Values: 3483.7 3494.5 3529.5 3530.3 3546.5 6150.5 6234.5 6240.1 6252.6 6300.0 6110.2 6154.8 6180.9 6183.2 6210.6 5410.6 5416.4 5430.9 5435.2 5441.3 5449.2 5471.7 5528.8 5559.8 5614.7 5532.1 5570.1 5579.1 5591.5 5608.2 5338.8 5436.3 5489.1 5504.8 5595.8 5257.4 5409.9 5435.4 5479.9 5513.3 6115.4 6148.0 6159.8 6223.8 6237.0 6543.8 6690.8 6744.7 6823.0 6829.0 6719.5 6736.1 6766.5 6768.4 6777.6 6255.2 6339.0 6346.0 6355.1 6373.7 6857.8 6927.5 7015.4 7017.0 7031.0 6653.7 6680.3 6723.4 6748.8 6752.2 6450.0 6616.2 6676.9 6782.9 6818.2 6730.9 6736.4 6751.2 6773.3 6800.3 6736.6 6744.5 6816.6 6818.8 6825.5 4848.3 4894.8 4912.7 4913.0 4916.1 4286.4 4331.6 4339.1 4401.1 4419.0 6501.4 6526.5 6556.3 6563.4 6584.4 6794.0 6800.7 6805.4 6878.9 6885.9 6465.9 6477.9 6485.7 6502.3 6550.9 5349.2 5412.7 5426.4 5430.8 5432.6 7087.8 7099.1 7152.9 7169.3 7172.4 6527.0 6643.5 6771.3 6850.6 6855.5 7180.0 7239.9 7242.7 7250.1 7251.4 6642.1 6683.7 6763.0 6769.9 6771.1 6674.8 6782.5 6788.2 6801.7 6885.8 6630.0 6690.6 6694.2 6696.0 6703.9 6534.9 6592.7 6663.3 6699.3 6706.9 6550.2 6575.7 6589.1 6648.0 6674.1 6667.9 6698.8 6738.5 6749.1 6755.1 6228.4 6368.5 6441.5 6526.5 6534.2 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#1] ext.html Cycles:180 Average:41820.54 Median:37250.85 stddev:62090.82 (166.7%) stddev-sans-first:62189.00 18:15:29 INFO - PID 27384 | Values: 904.1 915.5 940.9 964.1 966.5 35412.9 36503.5 44435.0 45191.8 45238.3 45311.1 45419.8 45430.5 45641.8 45667.3 7822.7 7825.5 7942.8 7944.9 7947.0 7736.1 7793.8 7828.2 7854.7 7866.6 7863.4 7916.6 7917.4 7919.4 7921.8 7857.3 7875.8 7877.7 7877.8 7878.5 7446.9 7497.0 7498.3 7503.2 7511.1 40163.4 40288.8 40357.0 40411.2 40469.6 3545.2 3545.8 3572.0 3584.1 3585.9 31834.5 31836.0 31895.5 31922.5 31954.2 5212.5 5227.2 5247.7 5271.4 5279.2 209272.0 209567.0 210138.0 210726.0 210741.9 51177.5 51246.5 51411.7 51414.2 51421.5 53755.4 53817.0 53822.2 54003.2 54031.7 14307.6 14572.3 16832.8 17138.4 17169.0 13836.9 13989.2 14020.2 14046.0 14052.5 15574.8 15674.3 15697.0 15714.4 15731.4 5986.0 6072.7 6238.2 6269.2 6285.3 1083.7 1086.9 1091.2 1101.5 1107.2 24072.8 24126.3 24203.8 24350.5 24496.2 1186.9 1201.9 1204.7 1210.8 1219.6 13022.5 13037.7 13216.7 13296.0 13358.2 268185.0 269067.0 269504.0 270013.0 270584.0 56379.4 56579.7 56708.0 56854.7 56880.4 1551.1 1561.1 1578.1 1582.4 1609.9 23349.2 23475.9 23579.4 23686.2 23746.4 40190.4 40204.6 40289.0 40291.4 40308.0 232994.0 233304.0 233460.0 234526.0 234555.0 36505.6 38474.8 38605.6 38968.0 39273.4 47857.0 48948.5 49065.0 49755.0 50138.2 36539.3 36990.6 37028.8 37301.4 37366.0 36012.1 36237.5 36476.3 36812.3 37200.3 41636.8 42065.6 42166.8 42294.8 42327.8 35733.6 35738.0 35872.5 36110.3 36740.8 25911.2 25984.4 26083.5 26592.0 26786.2 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#2] jquery.html Cycles:180 Average:39524.84 Median:22773.99 stddev:96368.43 (423.2%) stddev-sans-first:96594.37 18:15:29 INFO - PID 27384 | Values: 567.2 568.6 573.0 574.2 588.9 23276.5 23726.8 24550.4 24585.6 24593.8 26489.7 26867.9 27050.1 27067.6 27068.0 6302.6 6456.8 6457.6 6461.5 6461.5 5646.5 6115.9 6180.4 6183.7 6192.0 6069.2 6096.7 6134.3 6155.4 6156.8 6119.6 6140.3 6141.5 6144.2 6147.0 5653.8 5736.2 5749.5 5750.5 5756.8 30316.7 30836.5 30989.2 31112.7 31436.2 2198.5 2227.8 2236.0 2236.1 2237.3 20237.3 20445.8 21670.8 21672.9 21712.7 2464.3 2501.5 2542.6 2542.9 2552.3 160899.2 162692.2 169265.0 169631.0 169723.0 15243.6 15343.0 15408.6 15793.9 15891.0 23280.8 23429.5 23436.6 23440.8 23483.0 10656.0 10811.5 10879.7 10882.3 10931.7 10026.4 10042.2 10089.4 10131.6 10135.3 9713.7 9803.9 9818.4 9893.5 9934.0 2789.9 2791.7 2791.9 2813.2 2943.4 1030.7 1042.1 1042.3 1042.3 1057.7 20539.8 20666.0 20712.7 21272.6 21356.1 1097.6 1117.8 1122.3 1131.4 1131.5 11473.3 11578.2 11587.3 11601.2 11751.8 548218.0 559807.0 566590.0 579386.0 587371.0 132830.0 138040.0 138092.0 138285.0 138658.3 1194.3 1270.2 1283.8 1300.6 1314.1 22729.7 22818.3 22835.9 22871.8 22889.9 63474.4 65693.0 65925.3 66684.3 68427.7 83769.6 83776.6 83858.6 83971.0 84349.0 14410.6 14845.5 14849.3 14873.3 14881.7 23842.6 24119.6 24274.0 24337.4 24337.6 19528.9 19608.1 19810.6 19819.0 20115.2 17597.6 17637.4 18013.0 18119.8 18145.8 19367.3 19918.0 19972.1 20013.6 20119.3 14599.4 14718.9 14731.1 14736.1 14743.1 19299.7 19357.2 19626.0 19654.3 19807.4 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#3] mootools.html Cycles:180 Average:10077.05 Median:13357.52 stddev:7364.82 (55.1%) stddev-sans-first:7356.84 18:15:29 INFO - PID 27384 | Values: 1431.9 1486.6 1486.9 1500.0 1501.1 15557.0 15834.9 16094.5 16139.5 16158.7 16451.5 16656.1 16660.3 16664.8 16678.9 2470.5 2478.6 2479.5 2481.1 2535.0 2559.9 2615.4 2642.2 2643.7 2678.1 2406.3 2406.4 2429.3 2431.4 2432.4 2592.2 2609.9 2621.8 2622.7 2630.4 2601.5 2612.0 2614.1 2616.0 2619.3 15452.2 15768.4 15771.0 15775.2 15778.4 8120.8 8184.8 8529.2 8537.9 8549.7 5337.1 5342.3 5441.1 5457.2 5488.6 1856.5 1880.7 1880.9 1931.1 1968.5 28297.2 28298.7 28457.7 28490.0 28517.6 6735.2 6761.2 6824.9 6929.7 6961.0 18781.5 18806.4 18823.9 18831.0 18832.3 8201.7 8322.8 8334.8 8367.2 8369.2 7526.8 7592.8 7791.9 7792.0 7793.5 4953.6 5180.2 5387.0 5413.2 5449.0 1348.8 1519.0 1527.6 1552.6 1566.3 923.5 926.9 934.9 938.2 945.3 8993.0 9203.9 9262.3 9299.2 9468.0 1012.1 1017.1 1031.5 1031.7 1032.3 5013.2 6173.1 6257.9 6298.4 6346.8 24005.9 24240.6 24285.8 24365.5 24382.5 23386.5 23642.5 23905.3 23956.9 24160.5 12807.9 12979.4 13068.1 13070.9 13105.7 9327.6 9891.2 9909.3 9919.6 10020.4 19896.4 20130.2 20331.4 20735.6 20833.0 20834.9 21159.2 21189.3 21201.6 21429.7 13134.9 13148.5 13219.6 13251.3 13354.3 14625.0 14818.8 14820.6 14820.8 14852.8 11392.6 11974.5 12148.9 12191.5 12355.9 10918.2 11124.5 11298.9 11425.0 11444.1 10391.6 10399.1 10461.1 10521.0 10531.3 8063.2 8275.2 8299.3 8393.7 8408.3 7974.8 7981.1 7989.8 8011.6 8042.1 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#4] prototype.html Cycles:180 Average:5571.69 Median:6210.35 stddev:1598.31 (25.7%) stddev-sans-first:1556.94 18:15:29 INFO - PID 27384 | Values: 507.3 510.0 529.2 530.0 531.5 6055.6 6084.8 6109.1 6121.6 6176.8 5852.4 5903.9 5907.2 5961.6 6016.7 4737.2 4740.9 4781.2 4792.6 4804.5 4654.5 4754.5 4762.6 4765.8 4824.3 4716.9 4748.4 4756.4 4773.0 4783.7 4749.1 4759.8 4781.7 4788.5 4795.8 4320.3 4329.9 4331.8 4359.5 4363.6 6024.7 6055.3 6078.1 6093.6 6113.4 5777.2 5777.8 5783.0 5791.2 5795.1 6493.9 6525.6 6560.3 6560.6 6566.5 4921.2 4921.2 4924.2 4925.8 4931.1 6870.6 6914.7 6931.9 6950.9 6951.4 5067.8 5069.4 5076.9 5083.5 5085.8 5167.9 5174.0 5184.8 5190.0 5201.7 5666.2 5720.5 5732.4 5759.1 5789.9 6509.3 6548.7 6548.9 6551.6 6573.8 1692.6 1703.4 1704.1 1762.4 1786.0 1232.2 1243.0 1244.6 1258.1 1268.6 6185.6 6235.1 6275.0 6281.9 6313.7 6539.8 6704.2 6704.5 6705.0 6712.2 6298.1 6370.6 6379.1 6398.2 6438.6 3502.2 3560.0 3574.4 3576.1 3598.2 7073.2 7141.0 7149.9 7158.9 7161.7 6883.2 6920.8 6936.9 6945.9 6950.8 7097.9 7131.8 7139.0 7192.0 7195.2 6668.0 6670.5 6764.3 6778.6 6834.9 6657.9 6678.3 6706.3 6708.6 6711.3 7119.0 7123.2 7169.4 7186.1 7187.9 5418.3 5457.2 5461.6 5472.3 5492.9 6459.0 6615.7 6722.2 6782.4 6793.0 6334.1 6410.4 6412.6 6427.6 6567.2 6354.3 6388.5 6410.4 6415.7 6494.3 6393.4 6408.2 6410.9 6417.0 6522.6 6298.6 6415.7 6433.2 6504.4 6528.1 6274.3 6295.3 6328.1 6361.2 6418.9 18:15:29 INFO - PID 27384 | 18:15:29 INFO - PID 27384 | [#5] yui.html Cycles:180 Average:28260.99 Median:20729.79 stddev:40565.32 (195.7%) stddev-sans-first:40627.21 18:15:29 INFO - PID 27384 | Values: 930.1 931.1 956.8 958.1 958.7 18721.3 19378.3 20018.5 20043.9 20088.7 20406.4 20808.7 20844.1 20915.4 21005.9 1023.8 1038.3 1046.6 1048.3 1050.1 1100.8 1107.1 1107.1 1107.6 1110.5 1087.4 1131.4 1138.5 1141.7 1177.7 1106.2 1112.7 1119.9 1120.2 1121.1 811.6 812.0 812.1 815.4 826.9 20013.8 20307.1 20598.7 20648.6 20935.0 22481.9 22686.0 22915.5 23049.2 23131.7 17029.4 17052.0 17283.3 17380.0 17557.5 3765.4 3791.1 3791.2 3791.6 3793.0 147798.0 148465.0 148733.0 148772.3 149359.0 17328.1 17491.0 17744.4 17917.1 17932.7 32969.2 33184.2 33316.5 33330.2 33916.5 8387.7 8723.2 8923.6 9186.4 9296.9 3835.3 3929.8 3933.4 3945.2 3950.8 5444.6 5450.8 5511.4 5555.2 5560.3 1108.9 1128.7 1142.1 1147.4 1151.3 677.6 691.1 695.9 702.4 711.6 13127.1 13320.9 14940.6 15071.7 15235.1 693.7 696.3 703.8 720.4 721.3 5992.5 6096.0 6165.3 6172.6 6200.3 142202.0 142918.0 144189.3 145630.0 145759.3 127386.0 128348.4 129335.4 130060.0 132197.3 111585.4 112408.4 112702.0 113676.0 114111.4 11910.9 12206.8 12305.1 12386.0 12546.6 52352.2 53126.2 53861.7 54329.2 54405.7 67723.0 68978.7 68997.0 70687.0 93089.5 20891.2 20933.6 20945.8 20973.3 21137.8 23663.2 23676.4 23893.3 23943.3 24053.2 22032.2 22327.0 22644.3 22699.2 22707.9 19450.0 19734.5 19794.1 19819.6 19994.3 20650.9 20944.7 21042.7 21146.7 21460.7 14868.8 15093.4 15156.3 15248.8 15484.2 15205.8 15377.1 15730.4 16343.7 16546.2 18:15:29 INFO - PID 27384 | -------- Summary: end -------- 18:15:29 INFO - PID 27384 | 18:15:30 INFO - TEST-INFO | 27384: exit 0 18:15:30 INFO - TEST-OK | dromaeo_css | took 1111153ms 18:15:30 INFO - TEST-START | kraken 18:15:30 INFO - Initialising browser for kraken test... 18:15:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60211/getInfo.html -profile /tmp/tmpgG86oE/profile 18:15:30 INFO - TEST-INFO | started process 27794 (/builds/slave/test/build/application/firefox/firefox http://localhost:60211/getInfo.html) 18:15:36 INFO - TEST-INFO | 27794: exit 0 18:15:36 INFO - Browser initialized. 18:15:36 INFO - Running cycle 1/1 for kraken test... 18:15:36 INFO - TEST-INFO | started process 27971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgG86oE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:37 INFO - PID 27971 | 18:15:37 INFO - PID 27971 | (/builds/slave/test/build/application/firefox/firefox:28020): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:37 INFO - PID 27971 | 18:15:38 INFO - PID 27971 | 18:15:38 INFO - PID 27971 | (/builds/slave/test/build/application/firefox/firefox:28076): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:38 INFO - PID 27971 | 18:15:38 INFO - PID 27971 | __metrics Screen width/height:1600/1200 18:15:38 INFO - PID 27971 | colorDepth:24 18:15:38 INFO - PID 27971 | Browser inner width/height: 1024/768 18:15:38 INFO - PID 27971 | __metrics 18:15:47 INFO - PID 27971 | RSS: Main: 165949440 18:15:47 INFO - PID 27971 | 18:15:50 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60211/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:51 INFO - PID 27971 | RSS: Main: 169529344 18:15:51 INFO - PID 27971 | 18:15:53 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60211/tests/kraken/driver.html?testName=audio-dft) 18:15:54 INFO - PID 27971 | RSS: Main: 172142592 18:15:54 INFO - PID 27971 | 18:15:57 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60211/tests/kraken/driver.html?testName=audio-fft) 18:15:57 INFO - PID 27971 | RSS: Main: 165326848 18:15:57 INFO - PID 27971 | 18:15:59 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60211/tests/kraken/driver.html?testName=audio-oscillator) 18:16:00 INFO - PID 27971 | RSS: Main: 167133184 18:16:00 INFO - PID 27971 | 18:16:02 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:03 INFO - PID 27971 | RSS: Main: 166838272 18:16:03 INFO - PID 27971 | 18:16:06 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60211/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:06 INFO - PID 27971 | RSS: Main: 166195200 18:16:06 INFO - PID 27971 | 18:16:10 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60211/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:10 INFO - PID 27971 | RSS: Main: 168136704 18:16:10 INFO - PID 27971 | 18:16:13 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60211/tests/kraken/driver.html?testName=json-parse-financial) 18:16:14 INFO - PID 27971 | RSS: Main: 168685568 18:16:14 INFO - PID 27971 | 18:16:15 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:16 INFO - PID 27971 | RSS: Main: 168329216 18:16:16 INFO - PID 27971 | 18:16:18 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:18 INFO - PID 27971 | RSS: Main: 168022016 18:16:18 INFO - PID 27971 | 18:16:20 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:21 INFO - PID 27971 | RSS: Main: 168353792 18:16:21 INFO - PID 27971 | 18:16:24 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:24 INFO - PID 27971 | RSS: Main: 168091648 18:16:24 INFO - PID 27971 | 18:16:27 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:28 INFO - PID 27971 | RSS: Main: 168701952 18:16:28 INFO - PID 27971 | 18:16:29 INFO - PID 27971 | Cycle 1(1): loaded http://localhost:60211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60211/tests/kraken/driver.html?testName=ai-astar) 18:16:30 INFO - PID 27971 | RSS: Main: 170831872 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | __start_tp_report 18:16:30 INFO - PID 27971 | _x_x_mozilla_page_load 18:16:30 INFO - PID 27971 | _x_x_mozilla_page_load_details 18:16:30 INFO - PID 27971 | |i|pagename|runs| 18:16:30 INFO - PID 27971 | |0;ai-astar;96;105;99;106;106;106;108;98;105;108 18:16:30 INFO - PID 27971 | |1;audio-beat-detection;140;114;140;168;113;139;144;113;171;114 18:16:30 INFO - PID 27971 | |2;audio-dft;164;166;162;163;164;163;161;162;163;168 18:16:30 INFO - PID 27971 | |3;audio-fft;74;73;76;173;75;72;75;72;151;73 18:16:30 INFO - PID 27971 | |4;audio-oscillator;78;78;127;78;77;78;141;77;77;144 18:16:30 INFO - PID 27971 | |5;imaging-gaussian-blur;116;117;114;114;114;114;114;114;122;113 18:16:30 INFO - PID 27971 | |6;imaging-darkroom;147;151;151;148;150;149;149;148;148;148 18:16:30 INFO - PID 27971 | |7;imaging-desaturate;94;93;94;94;95;94;94;93;94;94 18:16:30 INFO - PID 27971 | |8;json-parse-financial;48;46;51;47;47;47;47;47;47;48 18:16:30 INFO - PID 27971 | |9;json-stringify-tinderbox;58;55;54;55;54;54;54;55;55;55 18:16:30 INFO - PID 27971 | |10;stanford-crypto-aes;74;71;73;79;71;72;74;72;72;73 18:16:30 INFO - PID 27971 | |11;stanford-crypto-ccm;113;116;121;115;119;117;117;117;117;160 18:16:30 INFO - PID 27971 | |12;stanford-crypto-pbkdf2;159;167;161;174;169;175;165;167;164;161 18:16:30 INFO - PID 27971 | |13;stanford-crypto-sha256-iterative;60;61;61;61;61;62;65;62;61;60 18:16:30 INFO - PID 27971 | __end_tp_report 18:16:30 INFO - PID 27971 | __start_cc_report 18:16:30 INFO - PID 27971 | _x_x_mozilla_cycle_collect,863 18:16:30 INFO - PID 27971 | __end_cc_report 18:16:30 INFO - PID 27971 | __startTimestamp1503364590175__endTimestamp 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | ------- Summary: start ------- 18:16:30 INFO - PID 27971 | Number of tests: 14 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#0] ai-astar Cycles:10 Average:103.70 Median:108.00 stddev:4.35 (4.0%) stddev-sans-first:3.61 18:16:30 INFO - PID 27971 | Values: 96.0 105.0 99.0 106.0 106.0 106.0 108.0 98.0 105.0 108.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:140.00 stddev:22.06 (15.8%) stddev-sans-first:23.34 18:16:30 INFO - PID 27971 | Values: 140.0 114.0 140.0 168.0 113.0 139.0 144.0 113.0 171.0 114.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 18:16:30 INFO - PID 27971 | Values: 164.0 166.0 162.0 163.0 164.0 163.0 161.0 162.0 163.0 168.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#3] audio-fft Cycles:10 Average:91.40 Median:73.50 stddev:37.59 (51.1%) stddev-sans-first:39.34 18:16:30 INFO - PID 27971 | Values: 74.0 73.0 76.0 173.0 75.0 72.0 75.0 72.0 151.0 73.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:77.50 stddev:29.19 (37.7%) stddev-sans-first:30.26 18:16:30 INFO - PID 27971 | Values: 78.0 78.0 127.0 78.0 77.0 78.0 141.0 77.0 77.0 144.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:114.00 stddev:2.66 (2.3%) stddev-sans-first:2.80 18:16:30 INFO - PID 27971 | Values: 116.0 117.0 114.0 114.0 114.0 114.0 114.0 114.0 122.0 113.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.37 (0.9%) stddev-sans-first:1.27 18:16:30 INFO - PID 27971 | Values: 147.0 151.0 151.0 148.0 150.0 149.0 149.0 148.0 148.0 148.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:16:30 INFO - PID 27971 | Values: 94.0 93.0 94.0 94.0 95.0 94.0 94.0 93.0 94.0 94.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.00 stddev:1.35 (2.9%) stddev-sans-first:1.42 18:16:30 INFO - PID 27971 | Values: 48.0 46.0 51.0 47.0 47.0 47.0 47.0 47.0 47.0 48.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:0.53 18:16:30 INFO - PID 27971 | Values: 58.0 55.0 54.0 55.0 54.0 54.0 54.0 55.0 55.0 55.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:2.33 (3.2%) stddev-sans-first:2.45 18:16:30 INFO - PID 27971 | Values: 74.0 71.0 73.0 79.0 71.0 72.0 74.0 72.0 72.0 73.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:117.00 stddev:13.80 (11.8%) stddev-sans-first:14.31 18:16:30 INFO - PID 27971 | Values: 113.0 116.0 121.0 115.0 119.0 117.0 117.0 117.0 117.0 160.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:167.00 stddev:5.37 (3.2%) stddev-sans-first:5.02 18:16:30 INFO - PID 27971 | Values: 159.0 167.0 161.0 174.0 169.0 175.0 165.0 167.0 164.0 161.0 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:1.43 (2.3%) stddev-sans-first:1.42 18:16:30 INFO - PID 27971 | Values: 60.0 61.0 61.0 61.0 61.0 62.0 65.0 62.0 61.0 60.0 18:16:30 INFO - PID 27971 | -------- Summary: end -------- 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:16:30 INFO - PID 27971 | 18:16:30 INFO - PID 27971 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:16:30 INFO - TEST-INFO | 27971: exit 0 18:16:30 INFO - TEST-OK | kraken | took 60450ms 18:16:30 INFO - SUITE-END | took 1171s 18:16:31 INFO - Completed test suite (00:19:31) 18:16:31 INFO - javascript benchmark 18:16:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8974.537106083933, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.7038851697603, 3494.4583589543613, 3529.4705794130878, 3530.258645684406, 3546.503489511469, 6150.507959363252, 6234.470070044046, 6240.063990401436, 6252.562320637558, 6300.0234963580715, 6110.236220472441, 6154.753809847612, 6180.907286390708, 6183.196184496021, 6210.565260431772, 5410.56715462764, 5416.350037995437, 5430.864228394283, 5435.157550579646, 5441.29263195784, 5449.209864569635, 5471.671699698031, 5528.75120619571, 5559.777608895639, 5614.747336369853, 5532.059549876531, 5570.053090974544, 5579.079451890433, 5591.4688104629995, 5608.2428872102155, 5338.786448542053, 5436.3476382833915, 5489.094299440588, 5504.80733174341, 5595.804146854861, 5257.421683614799, 5409.9459005409835, 5435.402105768362, 5479.945200547983, 5513.338399392059, 6115.419020366642, 6147.969260153715, 6159.81520554384, 6223.7821676241565, 6237.0, 6543.770968016097, 6690.83272918181, 6744.696488658022, 6823.0, 6829.0, 6719.496037797136, 6736.090627765238, 6766.49251306154, 6768.39084482394, 6777.593344399352, 6255.186825712673, 6338.968305158491, 6346.0, 6355.078513615546, 6373.74505019794, 6857.828554286083, 6927.515073944775, 7015.403690686247, 7017.017617533549, 7031.015657807911, 6653.667316634149, 6680.265170831205, 6723.394894459424, 6748.763793267212, 6752.22349429812, 6449.96775016122, 6616.172978377703, 6676.899846502306, 6782.864342713118, 6818.215905170969, 6730.9326906731285, 6736.360045795642, 6751.223609284897, 6773.288804675537, 6800.251972283045, 6736.562123461959, 6744.460443164535, 6816.556923799937, 6818.829529261709, 6825.522213445011, 4848.345473361122, 4894.804207831647, 4912.729799861042, 4912.95087049125, 4916.115099282092, 4286.421333120051, 4331.5884990925815, 4339.088791353851, 4401.075774087413, 4418.955810441918, 6501.382368674968, 6526.477881769447, 6556.27880933097, 6563.3764792344655, 6584.407403333723, 6794.048833163361, 6800.6939687714175, 6805.353491418307, 6878.931210687929, 6885.862282754317, 6465.870682586322, 6477.935220647827, 6485.7405703772265, 6502.284748677642, 6550.934490655128, 5349.170878513836, 5412.7293635318865, 5426.375966763794, 5430.8099216527235, 5432.619716619878, 7087.751928682472, 7099.148102227766, 7152.92847071533, 7169.318914703095, 7172.426205903515, 6526.967365163144, 6643.534952553275, 6771.28901465339, 6850.588964662136, 6855.520113592001, 7179.964100179465, 7239.8914016288745, 7242.710291588278, 7250.129984401906, 7251.383632391306, 6642.070110184482, 6683.732650693918, 6762.966185169043, 6769.89845152333, 6771.052052712525, 6674.799756007327, 6782.491313151435, 6788.2193547742645, 6801.727930882709, 6885.793426197222, 6630.0, 6690.6320152390135, 6694.230163531061, 6696.0, 6703.899441508479, 6534.934650653623, 6592.67036648156, 6663.333666633298, 6699.263081061177, 6706.899396509154, 6550.213974323112, 6575.671216439063, 6589.143411356493, 6647.966760166169, 6674.065630811593, 6667.933320666732, 6698.83252918681, 6738.49461290415, 6749.122614060141, 6755.121834161528, 6228.408301211378, 6368.522360822864, 6441.484681225585, 6526.543141980016, 6534.150560427114], "value": 6161.566009859835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.1275169461468, 915.5422288855572, 940.877685900833, 964.1081999150783, 966.5022513405597, 35412.93761187162, 36503.45244821326, 44435.0, 45191.77404112983, 45238.32142517865, 45311.09377812442, 45419.772901135446, 45430.54569454313, 45641.77179114108, 45667.314990275176, 7822.687092516292, 7825.45221834469, 7942.801429964239, 7944.880826787603, 7947.0, 7736.110347310075, 7793.844123117534, 7828.217178282155, 7854.7250846220395, 7866.646000929972, 7863.449558530905, 7916.643751031189, 7917.406194535404, 7919.445638805286, 7921.801954951115, 7857.292843644071, 7875.763727088197, 7877.724279650185, 7877.7636670899965, 7878.527288362717, 7446.925530744677, 7496.962515187389, 7498.250174982512, 7503.21216272289, 7511.136219334791, 40163.39754903679, 40288.79855600703, 40357.0, 40411.191776164604, 40469.595304046874, 3545.2377738786286, 3545.840437180333, 3572.0, 3584.068142282999, 3585.8924232273075, 31834.522482162785, 31836.0, 31895.52156717651, 31922.521162182355, 31954.201144971328, 5212.452692467312, 5227.242049902781, 5247.658902171384, 5271.393789714193, 5279.234510995884, 209272.0, 209567.0, 210138.0, 210726.0, 210741.9462902691, 51177.48822511802, 51246.48753512417, 51411.742941285804, 51414.22878656823, 51421.48578514167, 53755.43078838264, 53817.0, 53822.19266711002, 54003.18995215075, 54031.72984135054, 14307.642308942151, 14572.344244509022, 16832.831671683372, 17138.40015599448, 17169.0, 13836.86163138376, 13989.160650361011, 14020.228887411085, 14046.0, 14052.508162214273, 15574.831887608474, 15674.294656740474, 15696.979696319702, 15714.449994250146, 15731.370745170065, 5986.0, 6072.696365181723, 6238.157848690459, 6269.185005949197, 6285.277193122758, 1083.7019819549687, 1086.8804431512526, 1091.24158709696, 1101.4823033174396, 1107.2470719910539, 24072.762812777568, 24126.311158218756, 24203.757962420503, 24350.51298974046, 24496.164218313224, 1186.9436201780422, 1201.9399030048462, 1204.6928033351614, 1210.7639010393066, 1219.6402061391912, 13022.544210952572, 13037.696230377076, 13216.73566528664, 13296.0, 13358.198508089547, 268185.0, 269067.0, 269504.0, 270013.0, 270584.0, 56379.43620563824, 56579.71710141505, 56708.0, 56854.715726421106, 56880.43119568834, 1551.0771091200718, 1561.0789634115927, 1578.0531680991544, 1582.37496189007, 1609.8953568018276, 23349.182778603346, 23475.882620586788, 23579.41051473727, 23686.170984015476, 23746.406339840953, 40190.397144042276, 40204.597954020086, 40289.0, 40291.395629065, 40308.0, 232994.0, 233304.0, 233460.0, 234526.0, 234555.0, 36505.63494365128, 38474.807625961694, 38605.613943861325, 38968.0, 39273.410898837115, 47857.0, 48948.5105148944, 49065.0, 49755.0, 50138.247926280404, 36539.26921461503, 36990.63009369872, 37028.81485592555, 37301.440478393386, 37366.0, 36012.09969750777, 36237.45643815292, 36476.27047459089, 36812.26375472529, 37200.25599487941, 41636.79181604073, 42065.57934420617, 42166.789166053975, 42294.78852605717, 42327.78836105923, 35733.64266357303, 35738.0, 35872.4619130708, 36110.27779444344, 36740.81629591835, 25911.22266332013, 25984.35039124037, 26083.478330433663, 26592.0, 26786.19641410761], "value": 18418.285765660774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2229046206696, 568.6019786149697, 572.9828105156844, 574.2161948939696, 588.9146073819296, 23276.534469310605, 23726.76273237267, 24550.386240344, 24585.631215531783, 24593.754062459393, 26489.735102648967, 26867.86566067172, 27050.05324813632, 27067.593986090225, 27068.0, 6302.621842689442, 6456.838579035515, 6457.612543247396, 6461.450776683988, 6461.483081353504, 5646.520045796112, 6115.877682446348, 6180.443760061594, 6183.690815459209, 6191.969040154793, 6069.21100256966, 6096.72564734588, 6134.325224225332, 6155.415235552616, 6156.7537298508005, 6119.571629985903, 6140.324564297924, 6141.477974372184, 6144.201253837017, 6147.0164773636225, 5653.830385088454, 5736.225609542742, 5749.482546570829, 5750.453706897838, 5756.827295181151, 30316.69683303161, 30836.53745193824, 30989.210971012493, 31112.688873111205, 31436.21409464759, 2198.4613769626385, 2227.7772222777594, 2235.9552808943895, 2236.0720301075035, 2237.272886311955, 20237.291694790612, 20445.79554204454, 21670.78329216719, 21672.89163554172, 21712.674309885366, 2464.2730394533655, 2501.524710305036, 2542.631318458813, 2542.8855701493476, 2552.2598446450506, 160899.19550402174, 162692.18653906655, 169264.99999999878, 169631.0, 169723.0, 15243.618909527351, 15343.0, 15408.61478463025, 15793.921030394775, 15891.0, 23280.7671923282, 23429.531409371717, 23436.64845027326, 23440.765592343858, 23483.0, 10656.04095631397, 10811.513481893333, 10879.728006799893, 10882.347059176474, 10931.726706832234, 10026.398416095057, 10042.196624270187, 10089.445080520494, 10131.594736210616, 10135.34120282194, 9713.660021899199, 9803.901960980442, 9818.361806482555, 9893.466512690544, 9934.0, 2789.9442011159663, 2791.7487426131747, 2791.930201744932, 2813.212300555848, 2943.411317736461, 1030.6598822388594, 1042.135027926819, 1042.312074031151, 1042.3433237060603, 1057.6826951914395, 20539.827519011833, 20666.0, 20712.689309660367, 21272.574548509252, 21356.14575416997, 1097.6432659385732, 1117.8267368557886, 1122.259308856151, 1131.3833960491552, 1131.4851742457163, 11473.254238474472, 11578.189526733217, 11587.304761714324, 11601.245919015237, 11751.764964700658, 548218.0, 559807.0, 566590.0, 579386.0, 587371.0, 132830.0, 138040.0, 138092.0, 138285.0, 138658.30670846583, 1194.3073017649915, 1270.1743866486856, 1283.813846992181, 1300.6163181861373, 1314.1195399082828, 22729.659055113854, 22818.31545053651, 22835.88582057079, 22871.771282286965, 22889.88555057214, 63474.36525634684, 65693.0, 65925.34074659384, 66684.33315666781, 68427.65786171037, 83769.58115209629, 83776.58111709403, 83858.58070709607, 83971.0, 84349.0, 14410.639734006314, 14845.480408185662, 14849.331780069706, 14873.256337183315, 14881.702365952404, 23842.64236036426, 24119.638205427284, 24274.0, 24337.39156521101, 24337.634935475628, 19528.9023554887, 19608.11763470619, 19810.60378792445, 19819.0, 20115.19539218415, 17597.560060998065, 17637.382691605733, 18013.0, 18119.818801811813, 18145.81854181494, 19367.3221437249, 19918.0, 19972.10125544325, 20013.59972800565, 20119.295824646066, 14599.416023358946, 14718.852811471748, 14731.116133032052, 14736.115833050051, 14743.11541307525, 19299.710504342165, 19357.225710971405, 19626.0, 19654.312099076462, 19807.405777826687], "value": 12700.380227004613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.9212443315616, 1486.5986183730392, 1486.8810495160387, 1500.047469856641, 1501.1218437214236, 15557.0, 15834.920825395857, 16094.517164485054, 16139.515814525568, 16158.676826463477, 16451.506454806346, 16656.08391538465, 16660.250288737006, 16664.83335166648, 16678.916605416955, 2470.4935488224914, 2478.62820576914, 2479.5412848622973, 2481.1192026830486, 2534.974650253492, 2559.8720063996725, 2615.372310645441, 2642.180923913593, 2643.74884385984, 2678.129607877438, 2406.2540612410207, 2406.3743426709007, 2429.2833614083797, 2431.4286142756437, 2432.3675844280524, 2592.1575487966297, 2609.8695065246757, 2621.8164728469014, 2622.711501734808, 2630.4213073123883, 2601.50571391435, 2612.020492315382, 2614.058938782037, 2616.0, 2619.345163709073, 15452.227388630636, 15768.448104316409, 15771.0, 15775.211239438097, 15778.447754328543, 8120.837583248302, 8184.7953801155445, 8529.23236908675, 8537.871931921027, 8549.743507694717, 5337.092694241988, 5342.252084708144, 5441.129419292894, 5457.208704737831, 5488.56091512678, 1856.5080253732772, 1880.6614809334314, 1880.9153588088568, 1931.0730849192325, 1968.468513501361, 28297.15108546747, 28298.717012829813, 28457.715422845922, 28490.0, 28517.572236416472, 6735.225449073419, 6761.188657361148, 6824.897626535606, 6929.722811087601, 6960.965195173992, 18781.530461738566, 18806.435806925812, 18823.90588047051, 18831.0, 18832.34086806955, 8201.671933122609, 8322.8335433291, 8334.833303333899, 8367.163283671705, 8369.163083691583, 7526.774196773996, 7592.772216833504, 7791.883121753178, 7791.961040194763, 7793.454458187985, 4953.578945789576, 5180.171172612364, 5386.973065134649, 5413.2150838128255, 5448.972755136199, 1348.7639663058926, 1518.9696206076037, 1527.6257316957194, 1552.6351307442742, 1566.34996476461, 923.4690053219425, 926.8656044873455, 934.9111834375724, 938.1978408460805, 945.3240932733129, 8993.0, 9203.861942070875, 9262.305327100494, 9299.20956718673, 9468.005859384803, 1012.1245122968579, 1017.0744622393586, 1031.5409642708923, 1031.654395777423, 1032.3238278927315, 5013.24801279811, 6173.135760993465, 6257.937420625735, 6298.370162983757, 6346.841328966812, 24005.879970600035, 24240.636390454158, 24285.7571424287, 24365.512689746105, 24382.512349752906, 23386.532269354517, 23642.52714945726, 23905.28284151478, 23956.88021559881, 24160.516789664107, 12807.871921280854, 12979.41592628334, 13068.085234033717, 13070.869291307155, 13105.67235819093, 9327.626894924128, 9891.159251463418, 9909.30634855582, 9919.603215871284, 10020.448875311928, 19896.403107906786, 20130.194792208735, 20331.390058298275, 20735.585288294453, 20833.0, 20834.89582552138, 21159.153633854472, 21189.258375956768, 21201.57596848085, 21429.678554822003, 13134.868651313365, 13148.474061037452, 13219.603411897659, 13251.337433128112, 13354.265515396746, 14625.0493717908, 14818.777718334019, 14820.555383338517, 14820.777688334469, 14852.7772083421, 11392.601258955896, 11974.521019159485, 12148.93925530402, 12191.51233950632, 12355.876441235832, 10918.181136414642, 11124.4981927442, 11298.943505282421, 11425.0, 11444.084473242287, 10391.636292729718, 10399.064084232456, 10461.110805581611, 10521.0, 10531.315464494783, 8063.19368063189, 8275.213854683796, 8299.336053115858, 8393.706220282262, 8408.327333813402, 7974.800629984296, 7981.082175549654, 7989.800254993672, 8011.6394762237005, 8042.115367309708], "value": 7044.738311877204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.2847285327689, 509.98470045898625, 529.1744877990335, 529.9735013249336, 531.4658767938222, 6055.5761096723245, 6084.8478788030325, 6109.14471973924, 6121.602095863777, 6176.814695559135, 5852.414758524145, 5903.911441328372, 5907.202527658765, 5961.61249518781, 6016.669083200422, 4737.242041273397, 4740.857774266778, 4781.211100168477, 4792.586187074804, 4804.519548045185, 4654.534546545336, 4754.548317909793, 4762.595034464841, 4765.761711914408, 4824.252240902666, 4716.900979064318, 4748.35897153885, 4756.381670382845, 4772.952270477303, 4783.665143439943, 4749.097671442432, 4759.785809638574, 4781.708938586562, 4788.473267940523, 4795.832145874878, 4320.287152619845, 4329.9134017319475, 4331.805068771881, 4359.455068116486, 4363.607275345203, 6024.698765061729, 6055.303640081403, 6078.118672792464, 6093.6039157454625, 6113.388661133896, 5777.162311464856, 5777.826665200051, 5782.97108514459, 5791.21818554494, 5795.1017592273265, 6493.870122597569, 6525.57583757059, 6560.278369379364, 6560.621280040783, 6566.474682025427, 4921.163402221595, 4921.18800397934, 4924.162892308281, 4925.827596034157, 4931.137051016058, 6870.62211578363, 6914.720776656334, 6931.896021559681, 6950.930490695129, 6951.374376306107, 5067.771950262247, 5069.417017043087, 5076.898462030738, 5083.466236045236, 5085.771140298695, 5167.896642067138, 5174.0, 5184.844454666366, 5189.974050129801, 5201.713905735145, 5666.235058267163, 5720.513756330675, 5732.398098199712, 5759.136129580513, 5789.913151302734, 6509.251436084816, 6548.738050478023, 6548.934510654928, 6551.6069035858, 6573.835654108686, 1692.5514738594281, 1703.3782669325608, 1704.0712811517753, 1762.418401927361, 1786.0355408079492, 1232.1805999010737, 1242.9875701242872, 1244.6452760963264, 1258.0501721200435, 1268.587708994562, 6185.567010309235, 6235.127082208494, 6274.968625156845, 6281.8743625127245, 6313.747450101944, 6539.771108011292, 6704.195496540447, 6704.530682852153, 6704.96647516769, 6712.160979877515, 6298.086777417248, 6370.55406121567, 6379.138816259746, 6398.200224971879, 6438.645874476949, 3502.176988407722, 3560.0209942266083, 3574.392353299945, 3576.123849656851, 3598.208394153334, 7073.221945585981, 7140.9642951785945, 7149.89275160873, 7158.923912065443, 7161.749338773118, 6883.174019117738, 6920.788861949139, 6936.918924322683, 6945.930540694529, 6950.756723514653, 7097.9290207097265, 7131.786046418616, 7138.965394862543, 7192.0, 7195.2444993276, 6668.0, 6670.466362690876, 6764.289749576224, 6778.610694652673, 6834.897476537955, 6657.933420665731, 6678.298778628174, 6706.295838937037, 6708.563943343667, 6711.295313991961, 7119.0, 7123.180834203926, 7169.354758071799, 7186.065811444479, 7187.892181617175, 5418.322709661293, 5457.154141108134, 5461.590380721383, 5472.288602481652, 5492.917606235989, 6458.967705161444, 6615.702293396713, 6722.193336799615, 6782.423494002867, 6793.0, 6334.144890439732, 6410.391012853772, 6412.551121421456, 6427.58220715652, 6567.2447668518735, 6354.301026886947, 6388.520860935541, 6410.391012853772, 6415.679216039272, 6494.318096599978, 6393.360663933756, 6408.198975128109, 6410.935890641033, 6416.967915160394, 6522.608643481406, 6298.622082675054, 6415.743370265323, 6433.228012638326, 6504.447121994684, 6528.083150109896, 6274.341194174546, 6295.331737089767, 6328.114064030948, 6361.2048493938255, 6418.903716444163], "value": 5102.481029516171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.1163894300416, 931.1107891963175, 956.837337652599, 958.0754571838177, 958.6932181701858, 18721.25114995402, 19378.321758738446, 20018.49953751157, 20043.899780501095, 20088.69866951997, 20406.387808365773, 20808.68786968193, 20844.062017209224, 20915.37253882382, 21005.894970525165, 1023.7901230247782, 1038.3458421194637, 1046.5813674530173, 1048.3081166430159, 1050.1336397472078, 1100.8073587122262, 1107.058999850125, 1107.070061148635, 1107.595727559439, 1110.4614262082923, 1087.3801932898252, 1131.383396049151, 1138.4706111658077, 1141.6689160143549, 1177.6584790410814, 1106.1869525898458, 1112.6995711158022, 1119.9328040317607, 1120.2158489057651, 1121.103117505992, 811.6185392865344, 811.9675212991532, 812.1107387410776, 815.4332738746574, 826.8594338962331, 20013.79986200134, 20307.086181121886, 20598.691019634716, 20648.587028259502, 20935.0, 22481.887590562106, 22686.0, 22915.541689166123, 23049.19327823518, 23131.727754973468, 17029.403970861084, 17052.0, 17283.308667653404, 17380.0, 17557.473275801618, 3765.359888818907, 3791.052236940765, 3791.241751649681, 3791.6018818023986, 3792.981035094807, 147798.0, 148465.0, 148733.0, 148772.2561387197, 149359.0, 17328.133593320283, 17491.0, 17744.3789467368, 17917.10414479271, 17932.731009034876, 32969.17577060593, 33184.1703957403, 33316.50025249623, 33330.16674583155, 33916.49125263123, 8387.706430274911, 8723.171298726611, 8923.598438070303, 9186.40288381253, 9296.8605470918, 3835.3096442640035, 3929.7838618875667, 3933.4296527004, 3945.2109578084496, 3950.802459876995, 5444.564434845203, 5450.754716037709, 5511.3937466878615, 5555.2222688823595, 5560.277163968658, 1108.8724796648328, 1128.6952522818792, 1142.1319796954208, 1147.363213416545, 1151.3379806611233, 677.5900580149038, 691.0843132848995, 695.9478039147084, 702.4380495603599, 711.6157275071507, 13127.081104322606, 13320.866791331962, 14940.626484337978, 15071.698566028617, 15235.061511423515, 693.6774399904069, 696.3245651717926, 703.8064532253671, 720.4056653261081, 721.3327671903469, 5992.460678538865, 6096.0, 6165.32181460039, 6172.629642221481, 6200.286966998763, 142202.0, 142918.0, 144189.27905360406, 145630.0, 145759.2712036433, 127386.0, 128348.35825820811, 129335.35332323467, 130060.0, 132197.33901330433, 111585.44207279074, 112408.43795780969, 112702.0, 113675.99999999834, 114111.42944285391, 11910.880891191324, 12206.816897746363, 12305.138640295094, 12386.0, 12546.623601291976, 52352.21471678004, 53126.20310695266, 53861.73069134629, 54329.18506222331, 54405.72797135989, 67723.0, 68978.65510672414, 68997.0, 70687.0, 93089.5345523268, 20891.16435342569, 20933.581328373042, 20945.790542094383, 20973.265935692176, 21137.78862211358, 23663.171788987303, 23676.408089797893, 23893.283201503982, 23943.28170154898, 24053.158139465733, 22032.228871989402, 22327.0, 22644.320670379915, 22699.205527806447, 22707.88646056759, 19450.0, 19734.506637334183, 19794.109265083393, 19819.60360792805, 19994.300199492947, 20650.896745516777, 20944.685829712264, 21042.68435973431, 21146.682799758324, 21460.678089828976, 14868.776968345699, 15093.39626414931, 15156.317965691791, 15248.77126843076, 15484.225788710293, 15205.847941520444, 15377.077375357514, 15730.370785168923, 16343.67312653764, 16546.172691365144], "value": 10084.196845116736, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 99.0, 106.0, 106.0, 106.0, 108.0, 98.0, 105.0, 108.0], "value": 103.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 140.0, 168.0, 113.0, 139.0, 144.0, 113.0, 171.0, 114.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 162.0, 163.0, 164.0, 163.0, 161.0, 162.0, 163.0, 168.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 173.0, 75.0, 72.0, 75.0, 72.0, 151.0, 73.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 127.0, 78.0, 77.0, 78.0, 141.0, 77.0, 77.0, 144.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 122.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 151.0, 148.0, 150.0, 149.0, 149.0, 148.0, 148.0, 148.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 51.0, 47.0, 47.0, 47.0, 47.0, 47.0, 47.0, 48.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 73.0, 79.0, 71.0, 72.0, 74.0, 72.0, 72.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 121.0, 115.0, 119.0, 117.0, 117.0, 117.0, 117.0, 160.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 167.0, 161.0, 174.0, 169.0, 175.0, 165.0, 167.0, 164.0, 161.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 65.0, 62.0, 61.0, 60.0], "value": 61.4, "unit": "score"}]}]} 18:16:31 INFO - Return code: 0 18:16:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:31 INFO - # TBPL SUCCESS # 18:16:31 INFO - Running post-action listener: _package_coverage_data 18:16:31 INFO - Running post-action listener: _resource_record_post_action 18:16:31 INFO - [mozharness: 2017-08-22 01:16:31.493353Z] Finished run-tests step (success) 18:16:31 INFO - Running post-run listener: _resource_record_post_run 18:16:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 430026752; Read time: 0; Write time: 473048 18:16:31 INFO - TinderboxPrint: CPU usage
13.1% 18:16:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:16:31 INFO - TinderboxPrint: I/O write bytes / time
430,026,752 / 473,048 18:16:31 INFO - TinderboxPrint: CPU idle
8,254.7 (86.9%) 18:16:31 INFO - TinderboxPrint: CPU user
1,188.8 (12.5%) 18:16:31 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:31 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 107614208; Read time: 0; Write time: 139068 18:16:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:16:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 320614400; Read time: 0; Write time: 333896 18:16:32 INFO - Running post-run listener: _upload_blobber_files 18:16:32 INFO - Blob upload gear active. 18:16:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:32 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 18:16:32 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'] 18:16:32 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 18:16:32 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:33 INFO - (blobuploader) - INFO - Done attempting. 18:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:34 INFO - (blobuploader) - INFO - Done attempting. 18:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:35 INFO - (blobuploader) - INFO - Done attempting. 18:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:38 INFO - (blobuploader) - INFO - Done attempting. 18:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:38 INFO - Return code: 0 18:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa618e2f9a461751432cd7ea19b674a5c2f4c3c3b6220a319452c616850d137e53e47456ef65127c2c272450dde88a9c10aa5a35f8b20984e5f801d16660221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7df1aaa8a62deb01207bbe72443cf9bf6de3533de7f87a6249250ab064ae6a614d99c00b2a537ce477f5287015c5c3554a2d3ff04799669052f5694527997ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c451cdc006e995187bbe76d989e90bb863e300066861c1bb423a7007896e6d37d0e271dc222780693e7cf33a652848a3ca05bd1d034b98eeb667da57270d0ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5698f8852b443811239492aadc85a66998559c5acb125afedcec906067a1b35315ff261e06ab7bf07a4e5f27b04e05e25af82176790cd34b80fcba435b246f"} 18:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:38 INFO - Contents: 18:16:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa618e2f9a461751432cd7ea19b674a5c2f4c3c3b6220a319452c616850d137e53e47456ef65127c2c272450dde88a9c10aa5a35f8b20984e5f801d16660221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7df1aaa8a62deb01207bbe72443cf9bf6de3533de7f87a6249250ab064ae6a614d99c00b2a537ce477f5287015c5c3554a2d3ff04799669052f5694527997ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c451cdc006e995187bbe76d989e90bb863e300066861c1bb423a7007896e6d37d0e271dc222780693e7cf33a652848a3ca05bd1d034b98eeb667da57270d0ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5698f8852b443811239492aadc85a66998559c5acb125afedcec906067a1b35315ff261e06ab7bf07a4e5f27b04e05e25af82176790cd34b80fcba435b246f"} 18:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:38 INFO - Copying logs to upload dir... 18:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.617040 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-21 18:16:37.412382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 18:16:37.417239) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 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/2aa618e2f9a461751432cd7ea19b674a5c2f4c3c3b6220a319452c616850d137e53e47456ef65127c2c272450dde88a9c10aa5a35f8b20984e5f801d16660221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7df1aaa8a62deb01207bbe72443cf9bf6de3533de7f87a6249250ab064ae6a614d99c00b2a537ce477f5287015c5c3554a2d3ff04799669052f5694527997ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c451cdc006e995187bbe76d989e90bb863e300066861c1bb423a7007896e6d37d0e271dc222780693e7cf33a652848a3ca05bd1d034b98eeb667da57270d0ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5698f8852b443811239492aadc85a66998559c5acb125afedcec906067a1b35315ff261e06ab7bf07a4e5f27b04e05e25af82176790cd34b80fcba435b246f"} build_url:https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/PE88c5nlQNS-k1dI4pmmxQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa618e2f9a461751432cd7ea19b674a5c2f4c3c3b6220a319452c616850d137e53e47456ef65127c2c272450dde88a9c10aa5a35f8b20984e5f801d16660221", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7df1aaa8a62deb01207bbe72443cf9bf6de3533de7f87a6249250ab064ae6a614d99c00b2a537ce477f5287015c5c3554a2d3ff04799669052f5694527997ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c451cdc006e995187bbe76d989e90bb863e300066861c1bb423a7007896e6d37d0e271dc222780693e7cf33a652848a3ca05bd1d034b98eeb667da57270d0ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5698f8852b443811239492aadc85a66998559c5acb125afedcec906067a1b35315ff261e06ab7bf07a4e5f27b04e05e25af82176790cd34b80fcba435b246f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 18:16:37.446319) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 18:16:37.446634) ========= 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=ba164b0a7b0ec7655860e956000001c1-1503363345.520758-337393673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 18:16:37.531246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 18:16:37.531670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 18:16:37.532089) ========= ========= Total master_lag: 0.02 =========