builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1501324461.24 results: success (0) revision: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.238620) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.239187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.239545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.255905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.256266) ========= 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=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-29 03:34:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.1M=0s 2017-07-29 03:34:21 (54.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.427174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.427532) ========= 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=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:21.477647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:21.478027) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-29 03:34:21,915 truncating revision to first 12 chars 2017-07-29 03:34:21,915 Setting DEBUG logging. 2017-07-29 03:34:21,915 attempt 1/10 2017-07-29 03:34:21,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fba314d7de7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-29 03:34:22,737 unpacking tar archive at: mozilla-central-2fba314d7de7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.176352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-29 03:34:22.667878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:22.668346) ========= script_repo_revision: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:22.668787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:22.669195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-29 03:34:22.677835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-29 03:34:22.678213) ========= /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=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:23 INFO - MultiFileLogger online at 20170729 03:34:23 in /builds/slave/test 03:34:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:34:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:23 INFO - {'append_to_log': False, 03:34:23 INFO - 'base_work_dir': '/builds/slave/test', 03:34:23 INFO - 'blob_upload_branch': 'Firefox', 03:34:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:23 INFO - 'branch': 'Firefox', 03:34:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:23 INFO - 'code_coverage': False, 03:34:23 INFO - 'config_files': ('talos/linux_config.py',), 03:34:23 INFO - 'default_actions': ('clobber', 03:34:23 INFO - 'read-buildbot-config', 03:34:23 INFO - 'download-and-extract', 03:34:23 INFO - 'populate-webroot', 03:34:23 INFO - 'create-virtualenv', 03:34:23 INFO - 'install', 03:34:23 INFO - 'setup-mitmproxy', 03:34:23 INFO - 'run-tests'), 03:34:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:23 INFO - 'disable_ccov_upload': False, 03:34:23 INFO - 'download_minidump_stackwalk': True, 03:34:23 INFO - 'download_symbols': 'ondemand', 03:34:23 INFO - 'enable_stylo': False, 03:34:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:23 INFO - 'gecko_profile': False, 03:34:23 INFO - 'gecko_profile_interval': 0, 03:34:23 INFO - 'installer_path': 'installer.exe', 03:34:23 INFO - 'log_level': 'info', 03:34:23 INFO - 'log_name': 'talos', 03:34:23 INFO - 'log_to_console': True, 03:34:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:23 INFO - 'opt_config_files': (), 03:34:23 INFO - 'pip_index': False, 03:34:23 INFO - 'suite': 'dromaeojs-e10s', 03:34:23 INFO - 'system_bits': '32', 03:34:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:23 INFO - 'title': 'talos-linux64-ix-030', 03:34:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:23 INFO - 'use_talos_json': True, 03:34:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:23 INFO - 'work_dir': 'build'} 03:34:23 INFO - [mozharness: 2017-07-29 10:34:23.221247Z] Running clobber step. 03:34:23 INFO - Running pre-action listener: _resource_record_pre_action 03:34:23 INFO - Running main action method: clobber 03:34:23 INFO - rmtree: /builds/slave/test/build 03:34:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:24 INFO - Running post-action listener: _resource_record_post_action 03:34:24 INFO - [mozharness: 2017-07-29 10:34:24.777847Z] Finished clobber step (success) 03:34:24 INFO - [mozharness: 2017-07-29 10:34:24.777948Z] Running read-buildbot-config step. 03:34:24 INFO - Running pre-action listener: _resource_record_pre_action 03:34:24 INFO - Running main action method: read_buildbot_config 03:34:24 INFO - Using buildbot properties: 03:34:24 INFO - { 03:34:24 INFO - "project": "", 03:34:24 INFO - "product": "firefox", 03:34:24 INFO - "who": "archaeopteryx@coole-files.de", 03:34:24 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:34:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:34:24 INFO - "stage_platform": "linux64-stylosequential", 03:34:24 INFO - "basedir": "/builds/slave/test", 03:34:24 INFO - "buildnumber": 156, 03:34:24 INFO - "platform": "ubuntu64_hw_styloseq", 03:34:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:34:24 INFO - "slavebuilddir": "test", 03:34:24 INFO - "taskId": "ZozqTzLhSuCSKYl9m3_BIA", 03:34:24 INFO - "branch": "mozilla-central", 03:34:24 INFO - "script_repo_revision": "production", 03:34:24 INFO - "revision": "2fba314d7de77ad8ab693a2ea0112c0cda5dd564", 03:34:24 INFO - "slavename": "talos-linux64-ix-030", 03:34:24 INFO - "repo_path": "mozilla-central" 03:34:24 INFO - } 03:34:24 INFO - Finding installer, test and symbols from parent task. 03:34:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZozqTzLhSuCSKYl9m3_BIA'}, attempt #1 03:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZozqTzLhSuCSKYl9m3_BIA'}, attempt #1 03:34:25 INFO - Task dependencies: H5ScIwu-Qs6tguCScglFqQ 03:34:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ'}, attempt #1 03:34:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/test_packages.json 03:34:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - [mozharness: 2017-07-29 10:34:26.099411Z] Finished read-buildbot-config step (success) 03:34:26 INFO - [mozharness: 2017-07-29 10:34:26.099632Z] Running download-and-extract step. 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: download_and_extract 03:34:26 INFO - mkdir: /builds/slave/test/build/tests 03:34: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')]} 03:34:26 INFO - trying https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json 03:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:26 INFO - Downloaded 989 bytes. 03:34:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:26 INFO - Using the following test package requirements: 03:34:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:26 INFO - u'common': [u'target.common.tests.zip'], 03:34:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:26 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:26 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:26 INFO - u'target.web-platform.tests.tar.gz'], 03:34:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip 03:34:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:26 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip into memory 03:34:28 INFO - Content-Length response header: 72567847 03:34:28 INFO - Bytes received: 72567847 03:34:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip 03:34:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.common.tests.zip into memory 03:34:40 INFO - Content-Length response header: 72567847 03:34:40 INFO - Bytes received: 72567847 03:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip 03:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.talos.tests.zip into memory 03:34:53 INFO - Content-Length response header: 14496686 03:34:53 INFO - Bytes received: 14496686 03:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:53 INFO - trying https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:53 INFO - Downloading https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:54 INFO - Downloaded 62119037 bytes. 03:34:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:54 INFO - mkdir: /builds/slave/test/properties 03:34:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:54 INFO - Contents: 03:34:54 INFO - build_url:https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 03:34:54 INFO - Running post-action listener: _resource_record_post_action 03:34:54 INFO - Running post-action listener: set_extra_try_arguments 03:34:54 INFO - [mozharness: 2017-07-29 10:34:54.910684Z] Finished download-and-extract step (success) 03:34:54 INFO - [mozharness: 2017-07-29 10:34:54.910782Z] Running populate-webroot step. 03:34:54 INFO - Running pre-action listener: _resource_record_pre_action 03:34:54 INFO - Running main action method: populate_webroot 03:34:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['damp', 'tps']}, 03:34:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:54 INFO - 'ts_paint', 03:34:54 INFO - 'tpaint', 03:34:54 INFO - 'sessionrestore', 03:34:54 INFO - 'sessionrestore_many_windows', 03:34:54 INFO - 'sessionrestore_no_auto_restore', 03:34:54 INFO - 'tabpaint']}, 03:34:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['quantum_pageload_google', 03:34:54 INFO - 'quantum_pageload_youtube', 03:34:54 INFO - 'quantum_pageload_amazon', 03:34:54 INFO - 'quantum_pageload_facebook']}, 03:34:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--stylo', 03:34:54 INFO - '--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['quantum_pageload_google', 03:34:54 INFO - 'quantum_pageload_youtube', 03:34:54 INFO - 'quantum_pageload_amazon', 03:34:54 INFO - 'quantum_pageload_facebook']}, 03:34:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:54 INFO - 'tsvgr_opacity', 03:34:54 INFO - 'tart', 03:34:54 INFO - 'tscrollx', 03:34:54 INFO - 'cart', 03:34:54 INFO - 'tsvg_static']}, 03:34:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:54 INFO - 'talos_options': ['--stylo', 03:34:54 INFO - '--stylo-threads=1', 03:34:54 INFO - '--mitmproxy', 03:34:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:54 INFO - '--firstNonBlankPaint'], 03:34:54 INFO - 'tests': ['tp6_google', 03:34:54 INFO - 'tp6_youtube', 03:34:54 INFO - 'tp6_amazon', 03:34:54 INFO - 'tp6_facebook']}, 03:34:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:54 INFO - 'talos_options': ['--xperf_path', 03:34:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:54 INFO - 'tests': ['tp5n']}}} 03:34:54 INFO - Running post-action listener: _resource_record_post_action 03:34:54 INFO - [mozharness: 2017-07-29 10:34:54.919486Z] Finished populate-webroot step (success) 03:34:54 INFO - [mozharness: 2017-07-29 10:34:54.919577Z] Running create-virtualenv step. 03:34:54 INFO - Running pre-action listener: _resource_record_pre_action 03:34:54 INFO - Running main action method: create_virtualenv 03:34:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:55 INFO - Using real prefix '/usr' 03:34:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:57 INFO - Installing pip.................done. 03:34:57 INFO - Return code: 0 03:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:57 INFO - Reading from file tmpfile_stdout 03:34:57 INFO - Output received: 03:34:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:34:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:34:57 INFO - Cleaning up... 03:34:57 INFO - Return code: 0 03:34:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:58 INFO - Downloading/unpacking psutil>=3.1.1 03:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:59 INFO - Installing collected packages: psutil 03:34:59 INFO - Running setup.py install for psutil 03:34:59 INFO - building 'psutil._psutil_linux' extension 03:34:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:34:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:34:59 INFO - building 'psutil._psutil_posix' extension 03:34:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:34:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:59 INFO - Successfully installed psutil 03:34:59 INFO - Cleaning up... 03:34:59 INFO - Return code: 0 03:34:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:34:59 INFO - Using env: {'DISPLAY': ':0', 03:34:59 INFO - 'HOME': '/home/cltbld', 03:34:59 INFO - 'LANG': 'en_US.UTF-8', 03:34:59 INFO - 'LANGUAGE': 'en_US:en', 03:34:59 INFO - 'LOGNAME': 'cltbld', 03:34:59 INFO - 'MAIL': '/var/mail/cltbld', 03:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:59 INFO - 'MOZ_NO_REMOTE': '1', 03:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:59 INFO - 'NO_EM_RESTART': '1', 03:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:59 INFO - 'PWD': '/builds/slave/test', 03:34:59 INFO - 'SHELL': '/bin/bash', 03:34:59 INFO - 'SHLVL': '1', 03:34:59 INFO - 'TERM': 'linux', 03:34:59 INFO - 'TMOUT': '86400', 03:34:59 INFO - 'USER': 'cltbld', 03:34:59 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:59 INFO - '_': '/tools/buildbot/bin/python'} 03:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:01 INFO - Installing collected packages: mozsystemmonitor 03:35:01 INFO - Running setup.py install for mozsystemmonitor 03:35:01 INFO - Successfully installed mozsystemmonitor 03:35:01 INFO - Cleaning up... 03:35:01 INFO - Return code: 0 03:35:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:35:01 INFO - Using env: {'DISPLAY': ':0', 03:35:01 INFO - 'HOME': '/home/cltbld', 03:35:01 INFO - 'LANG': 'en_US.UTF-8', 03:35:01 INFO - 'LANGUAGE': 'en_US:en', 03:35:01 INFO - 'LOGNAME': 'cltbld', 03:35:01 INFO - 'MAIL': '/var/mail/cltbld', 03:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:01 INFO - 'MOZ_NO_REMOTE': '1', 03:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:01 INFO - 'NO_EM_RESTART': '1', 03:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:01 INFO - 'PWD': '/builds/slave/test', 03:35:01 INFO - 'SHELL': '/bin/bash', 03:35:01 INFO - 'SHLVL': '1', 03:35:01 INFO - 'TERM': 'linux', 03:35:01 INFO - 'TMOUT': '86400', 03:35:01 INFO - 'USER': 'cltbld', 03:35:01 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:01 INFO - '_': '/tools/buildbot/bin/python'} 03:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:02 INFO - warning: no files found matching '*.txt' 03:35:02 INFO - no previously-included directories found matching 'build' 03:35:02 INFO - no previously-included directories found matching 'dist' 03:35:02 INFO - no previously-included directories found matching '.git*' 03:35:02 INFO - Installing collected packages: jsonschema, functools32 03:35:02 INFO - Running setup.py install for functools32 03:35:02 INFO - warning: no files found matching '*.txt' 03:35:02 INFO - no previously-included directories found matching 'build' 03:35:02 INFO - no previously-included directories found matching 'dist' 03:35:02 INFO - no previously-included directories found matching '.git*' 03:35:02 INFO - Successfully installed jsonschema functools32 03:35:02 INFO - Cleaning up... 03:35:03 INFO - Return code: 0 03:35:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:35:03 INFO - Using env: {'DISPLAY': ':0', 03:35:03 INFO - 'HOME': '/home/cltbld', 03:35:03 INFO - 'LANG': 'en_US.UTF-8', 03:35:03 INFO - 'LANGUAGE': 'en_US:en', 03:35:03 INFO - 'LOGNAME': 'cltbld', 03:35:03 INFO - 'MAIL': '/var/mail/cltbld', 03:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:03 INFO - 'MOZ_NO_REMOTE': '1', 03:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:03 INFO - 'NO_EM_RESTART': '1', 03:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:03 INFO - 'PWD': '/builds/slave/test', 03:35:03 INFO - 'SHELL': '/bin/bash', 03:35:03 INFO - 'SHLVL': '1', 03:35:03 INFO - 'TERM': 'linux', 03:35:03 INFO - 'TMOUT': '86400', 03:35:03 INFO - 'USER': 'cltbld', 03:35:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:03 INFO - '_': '/tools/buildbot/bin/python'} 03:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:35:03 INFO - Cleaning up... 03:35:03 INFO - Return code: 0 03:35:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:03 INFO - Using env: {'DISPLAY': ':0', 03:35:03 INFO - 'HOME': '/home/cltbld', 03:35:03 INFO - 'LANG': 'en_US.UTF-8', 03:35:03 INFO - 'LANGUAGE': 'en_US:en', 03:35:03 INFO - 'LOGNAME': 'cltbld', 03:35:03 INFO - 'MAIL': '/var/mail/cltbld', 03:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:03 INFO - 'MOZ_NO_REMOTE': '1', 03:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:03 INFO - 'NO_EM_RESTART': '1', 03:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:03 INFO - 'PWD': '/builds/slave/test', 03:35:03 INFO - 'SHELL': '/bin/bash', 03:35:03 INFO - 'SHLVL': '1', 03:35:03 INFO - 'TERM': 'linux', 03:35:03 INFO - 'TMOUT': '86400', 03:35:03 INFO - 'USER': 'cltbld', 03:35:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:03 INFO - '_': '/tools/buildbot/bin/python'} 03:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:05 INFO - Downloading docopt-0.6.1.tar.gz 03:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:05 INFO - Running setup.py install for blobuploader 03:35:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:05 INFO - Running setup.py install for requests 03:35:05 INFO - Running setup.py install for docopt 03:35:05 INFO - Successfully installed blobuploader requests docopt 03:35:05 INFO - Cleaning up... 03:35:05 INFO - Return code: 0 03:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:05 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:05 INFO - Using env: {'DISPLAY': ':0', 03:35:05 INFO - 'HOME': '/home/cltbld', 03:35:05 INFO - 'LANG': 'en_US.UTF-8', 03:35:05 INFO - 'LANGUAGE': 'en_US:en', 03:35:05 INFO - 'LOGNAME': 'cltbld', 03:35:05 INFO - 'MAIL': '/var/mail/cltbld', 03:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:05 INFO - 'MOZ_NO_REMOTE': '1', 03:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:05 INFO - 'NO_EM_RESTART': '1', 03:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:05 INFO - 'PWD': '/builds/slave/test', 03:35:05 INFO - 'SHELL': '/bin/bash', 03:35:05 INFO - 'SHLVL': '1', 03:35:05 INFO - 'TERM': 'linux', 03:35:05 INFO - 'TMOUT': '86400', 03:35:05 INFO - 'USER': 'cltbld', 03:35:05 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:05 INFO - '_': '/tools/buildbot/bin/python'} 03:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:05 INFO - Running setup.py (path:/tmp/pip-rBWiJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:05 INFO - Running setup.py (path:/tmp/pip-DvTas1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:06 INFO - Running setup.py (path:/tmp/pip-xkaNGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:06 INFO - Running setup.py (path:/tmp/pip-M4g7Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:06 INFO - Running setup.py (path:/tmp/pip-IqIWnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:06 INFO - Running setup.py (path:/tmp/pip-lxpeI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:06 INFO - Running setup.py (path:/tmp/pip-7Kl7K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:06 INFO - Running setup.py (path:/tmp/pip-zyrSvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:06 INFO - Running setup.py (path:/tmp/pip-zfvzXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:06 INFO - Running setup.py (path:/tmp/pip-29YGS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:06 INFO - Running setup.py (path:/tmp/pip-wLSaFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:06 INFO - Running setup.py (path:/tmp/pip-_PQlRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:06 INFO - Running setup.py (path:/tmp/pip-mAkAvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:06 INFO - Running setup.py (path:/tmp/pip-cIskmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:06 INFO - Running setup.py (path:/tmp/pip-xlZ_yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:06 INFO - Running setup.py (path:/tmp/pip-0Tvqde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:07 INFO - Running setup.py (path:/tmp/pip-92GIIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:07 INFO - Running setup.py install for manifestparser 03:35:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozcrash 03:35:07 INFO - Running setup.py install for mozdebug 03:35:07 INFO - Running setup.py install for mozdevice 03:35:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozfile 03:35:07 INFO - Running setup.py install for mozhttpd 03:35:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozinfo 03:35:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozInstall 03:35:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:07 INFO - Running setup.py install for mozleak 03:35:08 INFO - Running setup.py install for mozlog 03:35:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for moznetwork 03:35:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozprocess 03:35:08 INFO - Running setup.py install for mozprofile 03:35:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozrunner 03:35:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Running setup.py install for mozscreenshot 03:35:08 INFO - Running setup.py install for moztest 03:35:08 INFO - Running setup.py install for mozversion 03:35:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:08 INFO - Cleaning up... 03:35:08 INFO - Return code: 0 03:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:08 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:08 INFO - Using env: {'DISPLAY': ':0', 03:35:08 INFO - 'HOME': '/home/cltbld', 03:35:08 INFO - 'LANG': 'en_US.UTF-8', 03:35:08 INFO - 'LANGUAGE': 'en_US:en', 03:35:08 INFO - 'LOGNAME': 'cltbld', 03:35:08 INFO - 'MAIL': '/var/mail/cltbld', 03:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:08 INFO - 'MOZ_NO_REMOTE': '1', 03:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:08 INFO - 'NO_EM_RESTART': '1', 03:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:08 INFO - 'PWD': '/builds/slave/test', 03:35:08 INFO - 'SHELL': '/bin/bash', 03:35:08 INFO - 'SHLVL': '1', 03:35:08 INFO - 'TERM': 'linux', 03:35:08 INFO - 'TMOUT': '86400', 03:35:08 INFO - 'USER': 'cltbld', 03:35:08 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:08 INFO - '_': '/tools/buildbot/bin/python'} 03:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:09 INFO - Running setup.py (path:/tmp/pip-hiL9Is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:09 INFO - Running setup.py (path:/tmp/pip-ReHpXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:09 INFO - Running setup.py (path:/tmp/pip-71HWFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:09 INFO - Running setup.py (path:/tmp/pip-TplojR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:09 INFO - Running setup.py (path:/tmp/pip-in2RV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:09 INFO - Running setup.py (path:/tmp/pip-9TQXrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:09 INFO - Running setup.py (path:/tmp/pip-csPxLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:09 INFO - Running setup.py (path:/tmp/pip-8o5YYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:09 INFO - Running setup.py (path:/tmp/pip-q_dEWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:09 INFO - Running setup.py (path:/tmp/pip-I33T7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:09 INFO - Running setup.py (path:/tmp/pip-wYc7uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:09 INFO - Running setup.py (path:/tmp/pip-n_GthA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:09 INFO - Running setup.py (path:/tmp/pip-v1R3hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:10 INFO - Running setup.py (path:/tmp/pip-CxUz1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:10 INFO - Running setup.py (path:/tmp/pip-iolNm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:10 INFO - Running setup.py (path:/tmp/pip-qI12Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:10 INFO - Running setup.py (path:/tmp/pip-WUU5ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:11 INFO - Downloading blessings-1.6.tar.gz 03:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:11 INFO - Installing collected packages: blessings 03:35:11 INFO - Running setup.py install for blessings 03:35:11 INFO - Successfully installed blessings 03:35:11 INFO - Cleaning up... 03:35:11 INFO - Return code: 0 03:35:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:11 INFO - Reading from file tmpfile_stdout 03:35:11 INFO - Current package versions: 03:35:11 INFO - argparse == 1.2.1 03:35:11 INFO - blessings == 1.6 03:35:11 INFO - blobuploader == 1.2.4 03:35:11 INFO - docopt == 0.6.1 03:35:11 INFO - functools32 == 3.2.3-2 03:35:11 INFO - jsonschema == 2.5.1 03:35:11 INFO - manifestparser == 1.1 03:35:11 INFO - mozInstall == 1.13 03:35:11 INFO - mozcrash == 1.0 03:35:11 INFO - mozdebug == 0.1 03:35:11 INFO - mozdevice == 0.51 03:35:11 INFO - mozfile == 1.2 03:35:11 INFO - mozhttpd == 0.7 03:35:11 INFO - mozinfo == 0.10 03:35:11 INFO - mozleak == 0.1 03:35:11 INFO - mozlog == 3.5 03:35:11 INFO - moznetwork == 0.27 03:35:11 INFO - mozprocess == 0.25 03:35:11 INFO - mozprofile == 0.28 03:35:11 INFO - mozrunner == 6.13 03:35:11 INFO - mozscreenshot == 0.1 03:35:11 INFO - mozsystemmonitor == 0.3 03:35:11 INFO - moztest == 0.8 03:35:11 INFO - mozversion == 1.4 03:35:11 INFO - psutil == 3.1.1 03:35:11 INFO - requests == 1.2.3 03:35:11 INFO - wsgiref == 0.1.2 03:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:11 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:11 INFO - Using env: {'DISPLAY': ':0', 03:35:11 INFO - 'HOME': '/home/cltbld', 03:35:11 INFO - 'LANG': 'en_US.UTF-8', 03:35:11 INFO - 'LANGUAGE': 'en_US:en', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MAIL': '/var/mail/cltbld', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SHLVL': '1', 03:35:11 INFO - 'TERM': 'linux', 03:35:11 INFO - 'TMOUT': '86400', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - '_': '/tools/buildbot/bin/python'} 03:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:35:12 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:35:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:13 INFO - Installing collected packages: marionette-driver, simplejson 03:35:13 INFO - Running setup.py install for marionette-driver 03:35:13 INFO - Running setup.py install for simplejson 03:35:13 INFO - building 'simplejson._speedups' extension 03:35:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:35:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:35:14 INFO - Successfully installed marionette-driver simplejson 03:35:14 INFO - Cleaning up... 03:35:14 INFO - Return code: 0 03:35:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:14 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 0x24bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, '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': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:35:14 INFO - Using env: {'DISPLAY': ':0', 03:35:14 INFO - 'HOME': '/home/cltbld', 03:35:14 INFO - 'LANG': 'en_US.UTF-8', 03:35:14 INFO - 'LANGUAGE': 'en_US:en', 03:35:14 INFO - 'LOGNAME': 'cltbld', 03:35:14 INFO - 'MAIL': '/var/mail/cltbld', 03:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:14 INFO - 'MOZ_NO_REMOTE': '1', 03:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:14 INFO - 'NO_EM_RESTART': '1', 03:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:14 INFO - 'PWD': '/builds/slave/test', 03:35:14 INFO - 'SHELL': '/bin/bash', 03:35:14 INFO - 'SHLVL': '1', 03:35:14 INFO - 'TERM': 'linux', 03:35:14 INFO - 'TMOUT': '86400', 03:35:14 INFO - 'USER': 'cltbld', 03:35:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:14 INFO - '_': '/tools/buildbot/bin/python'} 03:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:14 INFO - Cleaning up... 03:35:14 INFO - Return code: 0 03:35:14 INFO - Running post-action listener: _resource_record_post_action 03:35:14 INFO - Running post-action listener: _start_resource_monitoring 03:35:14 INFO - Starting resource monitoring. 03:35:14 INFO - [mozharness: 2017-07-29 10:35:14.948174Z] Finished create-virtualenv step (success) 03:35:14 INFO - [mozharness: 2017-07-29 10:35:14.948642Z] Running install step. 03:35:14 INFO - Running pre-action listener: _resource_record_pre_action 03:35:14 INFO - Running main action method: install 03:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:15 INFO - Reading from file tmpfile_stdout 03:35:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:15 INFO - Reading from file tmpfile_stdout 03:35:15 INFO - Output received: 03:35:15 INFO - Usage: mozinstall [options] installer 03:35:15 INFO - Options: 03:35:15 INFO - -h, --help show this help message and exit 03:35:15 INFO - -d DEST, --destination=DEST 03:35:15 INFO - Directory to install application into. [default: 03:35:15 INFO - "/builds/slave/test"] 03:35:15 INFO - --app=APP Application being installed. [default: firefox] 03:35:15 INFO - mkdir: /builds/slave/test/build/application 03:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:33 INFO - Reading from file tmpfile_stdout 03:35:33 INFO - Output received: 03:35:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:33 INFO - Running post-action listener: _resource_record_post_action 03:35:33 INFO - [mozharness: 2017-07-29 10:35:33.269071Z] Finished install step (success) 03:35:33 INFO - [mozharness: 2017-07-29 10:35:33.269216Z] Running setup-mitmproxy step. 03:35:33 INFO - Running pre-action listener: _resource_record_pre_action 03:35:33 INFO - Running main action method: setup_mitmproxy 03:35:33 INFO - Skipping: mitmproxy is not required 03:35:33 INFO - Running post-action listener: _resource_record_post_action 03:35:33 INFO - [mozharness: 2017-07-29 10:35:33.270165Z] Finished setup-mitmproxy step (success) 03:35:33 INFO - [mozharness: 2017-07-29 10:35:33.270389Z] Running run-tests step. 03:35:33 INFO - Running pre-action listener: _resource_record_pre_action 03:35:33 INFO - Running pre-action listener: _set_gcov_prefix 03:35:33 INFO - Running main action method: run_tests 03:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:33 INFO - Python 2.7.3 03:35:33 INFO - Return code: 0 03:35:33 INFO - grabbing minidump binary from tooltool 03:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:33 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 0x282beb0>, '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 0x282cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282d240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:35:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:33 INFO - Return code: 0 03:35:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - ENV: RUST_BACKTRACE is now 1 03:35:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:35:33 INFO - Using env: {'DISPLAY': ':0', 03:35:33 INFO - 'HOME': '/home/cltbld', 03:35:33 INFO - 'LANG': 'en_US.UTF-8', 03:35:33 INFO - 'LANGUAGE': 'en_US:en', 03:35:33 INFO - 'LOGNAME': 'cltbld', 03:35:33 INFO - 'MAIL': '/var/mail/cltbld', 03:35:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:33 INFO - 'MOZ_NO_REMOTE': '1', 03:35:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:33 INFO - 'NO_EM_RESTART': '1', 03:35:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:33 INFO - 'PWD': '/builds/slave/test', 03:35:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:33 INFO - 'RUST_BACKTRACE': '1', 03:35:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:33 INFO - 'SHELL': '/bin/bash', 03:35:33 INFO - 'SHLVL': '1', 03:35:33 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:33 INFO - 'TERM': 'linux', 03:35:33 INFO - 'TMOUT': '86400', 03:35:33 INFO - 'USER': 'cltbld', 03:35:33 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351', 03:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:33 INFO - '_': '/tools/buildbot/bin/python'} 03:35:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:35:33 INFO - mozversion application_buildid: 20170729094428 03:35:33 INFO - mozversion application_changeset: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 03:35:33 INFO - mozversion application_display_name: Nightly 03:35:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:33 INFO - mozversion application_name: Firefox 03:35:33 INFO - mozversion application_remotingname: firefox 03:35:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:33 INFO - mozversion application_vendor: Mozilla 03:35:33 INFO - mozversion application_version: 56.0a1 03:35:33 INFO - mozversion platform_buildid: 20170729094428 03:35:33 INFO - mozversion platform_changeset: 2fba314d7de77ad8ab693a2ea0112c0cda5dd564 03:35:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:33 INFO - mozversion platform_version: 56.0a1 03:35:33 INFO - using testdate: 1501324533 03:35:33 INFO - actual date: 1501324533 03:35:33 INFO - starting webserver on 'localhost:51057' 03:35:33 INFO - SUITE-START | Running 2 tests 03:35:33 INFO - TEST-START | dromaeo_css 03:35:33 INFO - Initialising browser for dromaeo_css test... 03:35:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51057/getInfo.html -profile /tmp/tmp6qWJyT/profile 03:35:33 INFO - TEST-INFO | started process 26334 (/builds/slave/test/build/application/firefox/firefox http://localhost:51057/getInfo.html) 03:35:39 INFO - TEST-INFO | 26334: exit 0 03:35:39 INFO - Browser initialized. 03:35:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:39 INFO - TEST-INFO | started process 26562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6qWJyT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:40 INFO - PID 26562 | 03:35:40 INFO - PID 26562 | (/builds/slave/test/build/application/firefox/firefox:26616): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:40 INFO - PID 26562 | 03:35:51 INFO - PID 26562 | RSS: Main: 173281280 03:35:51 INFO - PID 26562 | 03:38:51 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51057/tests/dromaeo/cssquery-ext.html) 03:38:52 INFO - PID 26562 | RSS: Main: 175366144 03:38:52 INFO - PID 26562 | 03:41:54 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-ext.html (next: http://localhost:51057/tests/dromaeo/cssquery-jquery.html) 03:41:55 INFO - PID 26562 | RSS: Main: 172810240 03:41:55 INFO - PID 26562 | 03:44:57 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51057/tests/dromaeo/cssquery-mootools.html) 03:44:57 INFO - PID 26562 | RSS: Main: 175095808 03:44:57 INFO - PID 26562 | 03:47:59 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51057/tests/dromaeo/cssquery-prototype.html) 03:48:00 INFO - PID 26562 | RSS: Main: 173334528 03:48:00 INFO - PID 26562 | 03:51:04 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51057/tests/dromaeo/cssquery-yui.html) 03:51:04 INFO - PID 26562 | RSS: Main: 174432256 03:51:04 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | Cycle 1(1): loaded http://localhost:51057/tests/dromaeo/cssquery-yui.html (next: http://localhost:51057/tests/dromaeo/cssquery-dojo.html) 03:54:06 INFO - PID 26562 | RSS: Main: 175632384 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | __start_tp_report 03:54:06 INFO - PID 26562 | _x_x_mozilla_page_load 03:54:06 INFO - PID 26562 | _x_x_mozilla_page_load_details 03:54:06 INFO - PID 26562 | |i|pagename|runs| 03:54:06 INFO - PID 26562 | |0;dojo.html;3140.3248301615163;3143.669914658961;3165.4776961801304;3176.8093914365127;3198.968010319896;6094.725737341825;6108.389161083889;6158.045502947045;6174;6246.718897649605;6177.351378105302;6229;6265.060240963846;6301.401366870152;6306.369363063703;5685.658860468375;5722.54219662426;5737.856553586152;5791.160281759142;5813.912791308134;5557.527610153142;5610.69141197234;5638.633488823234;5641.858953526174;5728.112142617901;5657.066584013633;5674.0637794764025;5715.3998830122655;5720.456556627114;5720.971395143039;5630.127330263775;5687.260656114679;5688.772449102031;5718.513926316226;5719.628224165416;5535.114381698949;5583.3300003999375;5651.4913657770585;5652.406497317805;5704.743286552115;5962.34414214436;6050.69746512677;6092.603980741282;6094.177286066369;6097.993831017877;6618.602883826938;6638.800835974928;6668.333166683341;6676.632785196813;6683.198016238082;6661.833454163685;6752.426043786235;6757.797266082025;6758.425533829631;6765.763198288037;6179.876402471926;6233;6242.843928901813;6247.125402443661;6252.874942501125;6881.621510816853;6918.8616227676175;6930.792076237721;6934.861302773917;6944.826379340557;6523.315051919575;6550.901736473957;6573.934260657428;6605.504587155982;6611.272759996396;6614.669266536654;6615.206175259;6673.866522669617;6753.257141714407;6754.797356079325;6490.545661803629;6594.241662208811;6615.007748837713;6622.536422450478;6688.097106890507;5827.301172185153;6593.736250549924;6632.767853125118;6640.335966403321;6642.833929151713;5418.078926582411;5426;5475;5492.258545096361;5492.642978206404;4573.085382923428;4612.769361531977;4632.166210082218;4637.5130611286;4664.440267167962;5721.542276617861;5783.652980821164;5793.797217097382;5796;5798.420157984167;6773.966130169416;6782.287859774751;6784.3894049535775;6786.185657721105;6794.558353706993;5717.799877004285;5818.040023396177;5818.185454036354;5828;5843.590948633555;5921.555883308769;5942.554308426799;5942.970285148546;5958.076498142795;5979.730912108966;6421.325760795236;6454.32229615893;6463.385978332051;6547.443467305237;6561.376669216513;6573.506986976092;6702.497312701665;6705.798826035227;6780.491463140185;6795.218549866631;6412.487001039999;6424.967875160594;6428.517861160525;6442.033694945796;6451.451626611791;6536.477081833537;6542.411182993554;6547.279799222177;6550.967245163743;6571.342865713582;5888.499477544286;6678.599284042973;6679;6682.365175308338;6803.183617965876;6461.676916154268;6474.870502590016;6569.080328753883;6598.175228096488;6599.769008084694;6383.6808159592765;6449.871002580016;6487.9026814598765;6590.637514936724;6596.670166491752;6396.200474940632;6443.355664433519;6446.484281257394;6446.645434501147;6472.805815825533;6557.245916719638;6630.7679231226675;6637.037629543785;6661.766838160641;6676.198856137295;6344.238691357066;6359.236891573041;6373.5857169283845;6443.871122577429;6463.127477790438 03:54:06 INFO - PID 26562 | |1;ext.html;808.5431731071944;851.3019324154196;861.9525926074066;889.3996552327179;897.1925267259465;39977.4003389949;40728.79635601818;40864;40919.38620920689;41045;36494.45258321127;36504.269914601755;36744.26511469769;36929.63070369302;37023.62976370235;6795.7621483248095;6921.411680007205;6935.063766391523;6939.063226464438;6943.062686537303;6811.318868113199;7495.587742674151;7694.192109828471;7698;7698.653560589787;7701.9614901925415;7710.421718371116;7749.845003099935;7751.534907905516;7753.340966017867;7248.601326927043;7598.696052157907;7808.804779880492;7841.294283514454;7862.331701805382;7642.388608911329;7715.845683086307;7733.7679869604;7739.57432341221;7745.535267883945;37823.432648510294;37921.241575168344;38068.61931380678;38074.61925380738;38239.235215295535;3512.2799826035603;3545.468179773029;3547.2728090741334;3553.9693488888192;3562.91092722684;30989.0703278902;31342.43287835599;31450.056498305086;31518.684813152035;31566.053018409486;4831.347768051303;4842.322074909515;4871.342368780205;4877.122118018755;4885.36490256268;233093;234341;234891;236552;236669.81665091738;48723.26915096276;48982.26526602104;49220;49275.75362123166;49363.25955110676;51980.48019519832;52081.21878171831;52108;52140.73929630403;52152.478475215525;15047.398104075713;15302.311395987208;15359.846401536066;15372.077675339515;15445.0732956023;12365.319907404999;12378.44297006637;12387.07096967731;12395.566155184526;12427.689307767378;14020.509282175075;14035.298235088205;14056.578302650936;14094.154350738783;14145;5730.856728581735;5740.6268592541355;5816.563757718188;5822.679752613647;5856.970715146397;972.5817898303656;989.5398639632606;999.2605471950704;1025.6717850287837;1029.577873072037;21641.675374869388;21672.241471548736;21917.452063698216;22119.557608847732;22223.44441388978;1084.4848696869083;1093.1691914145306;1116.983245251322;1131.5643477261315;1133.8412622232895;11224.551017959353;12026.879731202576;12159.878401216052;15556.611084722746;15862.206889655472;230251;230719;231117;232419;232448;55755.16367254494;56954.7152264236;57805.13292300619;60211.39788602058;60354;1497.2588568658584;1539.638185026518;1542.4447199008348;1544.1744548286604;1547.4274518428253;26712.53081080559;27635.44729105447;27736.72263277422;27739.583906241827;27807;38282.80858595689;38844;38903;39006.41490377703;39039;199280;199819;200172;200177;200242;34398;35935;36342;36785.81607091947;36806.26387472289;44446.55553444424;45569;45675;45750;46121;30032.549511756904;30325.393492130475;32236.516452253705;32423.513647295782;33032.174195645304;32127.67872321247;32434.351312973136;32751.508727369586;33259.83370083134;33374.332513350084;38067.80966095152;38070.2385952285;38219;38398.80800595979;38477.80761096177;30273.848630756704;32846.507302390004;33054.5041824368;33301.333973320885;34220.31559368849;23468.295951121494;23515.52968940646;23726.169584065166;23729;24020.51958960776 03:54:06 INFO - PID 26562 | |2;jquery.html;554.869605642674;556.9387367389589;562.4488001758278;566.5920537213208;581.1631250998562;21432.357029289127;22269.888650556746;22297.77362245078;22300.21949231777;22363;25876.35309117273;26193.86903065482;26327.736722632817;26387.076452324174;26556.6016509752;6492.3832235937625;6657.334266573353;6658.267590565034;6659.800205993828;6659.9001014984815;6273.654948977827;6513.153290072284;6590.571612845174;6845.555038922479;6847.657617119125;6864.347886950732;6864.931350686479;6865.725370985155;6866.416354609864;6868.656567171646;6814.352636499525;6815.250322464525;6816.7614133505585;6855.862882742342;6873.725050997954;6707.295733947963;6709.463242940553;6715.899261511081;6716.865662686719;6743.15710536183;29748.70251297481;31521.369572608648;32205.677943220737;32312.6768732312;32409.67590324114;1867.9252829886789;1909.3794516782102;1924.5188702824294;1924.7594050743658;1931.565397785501;20053.498662533406;20320.898395508077;21265.36203913885;21276.255331063494;21368.46578835526;2455.588036878784;2481.10680155144;2520.785733212679;2523.8485690858606;2539.885705143273;135440;143445;143794.28102859523;143898;144108.2794586031;20807.479813004797;20823.687644685342;22569.4357641057;22954.885225573766;22974.770252297596;44135;44149;44259;44563.10873782506;44627.10745785066;11839.17125801203;11852.466639001266;12076.75846483083;12181.756364872654;12288.569900053633;10133.240006999504;10214.489275536194;10221.488925553693;10302.896971030345;10369.377837329785;9538.904610953941;11143.442827858575;11525.308481491138;11534.365609891369;11714.472848721827;3690.8523659053876;4164.6251837334785;4294.291441912112;4356.23572453157;4377.190219809346;923.132255679659;938.5448057692014;939.1735272959752;959.2757468111531;965.8647789309503;18318.08409579516;18923.243070277036;18984.525386865163;18989.430317090508;19447.708284375745;984.9510271560765;1025.1183981775666;1028.5782829040058;1048.6487026846091;1054;10648.840267395995;10877.67366978992;10988.945055274673;11042.558297668164;11393.886061139448;481525;483760;484511;490998;492815;114886.4255678733;118195.40902295434;121639;122470;123105.38447307707;1237.6287113865985;1246.6571692784376;1261.0920137500984;1270.5235536673747;1272.5991312736458;17162.742558861377;17266.65466690634;17523.474295771146;17555.133780680262;17967.910160449115;50005.249921250484;51947.701307467614;52440;52822;54334.7283263597;73530;73613.63193183999;74122.25877741154;74477;74672;14518.419263229353;14653.63365915818;14682.853171468576;14732.852671473149;14822.77765833535;22688.546229075655;23167.189148379726;23541.64687529654;23696.28911132669;24017.159399420936;18213.362532311305;18241.361552345603;18316.81683183151;18339.908300458414;18414.079296034877;14956.700865982837;15400.691986160438;16134.354625814836;16209;16731.74902376441;18900.716489252398;18904.243830246636;20120.798792011894;20326.59346813026;20368;14823.40706371733;15002.699946001238;15021.474248401692;15034.32345544475;15085.321160547583;18971.241150354384;19013.42959711211;19028.143733532303;19304.420867374;19373.128209230337 03:54:06 INFO - PID 26562 | |3;mootools.html;1306.4839388441562;1332.7934170203616;1359.354306704315;1364.270115488214;1370.3490841850119;13284.402201900913;13838.377273022714;13905.374258158381;13923.094998825069;13931.582052538415;14398.568042958701;14654.926725366358;14657.41370345185;14662;14662.193579353132;2617.908373206938;2650.0857204264594;2653.2040387883653;2658.601209818533;2660.0955675070472;2514.962275565868;2580.109862097573;2615.581506958887;2726.1003868723274;2731.0714357118577;2723.836569805818;2738.657667791526;2759.9448011039767;2765.4192619549917;2775.680796708374;2578.510083084208;2591.7019542752637;2655.2698008047746;2656.481986012728;2662.6405435266283;2604.0885690008536;2637.07702304192;2637.8261673555276;2655.309619498925;2663.1477927063347;13572.864271357259;13680.65798355049;13688.589342319747;13738.725225495535;13741.519046833413;7529.8117547061765;7817.765467035998;7842;7862.76411707644;7865.882011769828;4934.3338649282605;5094.286799848024;5242.13504771716;5256.106461901486;5258.474152584749;1726.326732574297;1802.4502526729343;1805.4944615507547;1835.3943198744382;1850.1396850464464;20064.59870802576;22428.55142897133;22604.77395226043;22655.433614159778;22678.433039173986;5892.616979896293;6539.117219175446;6767.72929082841;6779.2881747416795;6779.966100169468;15657.60855978587;15677.686446271011;15727;15747.68504629901;15764.68470630581;7778.572178530122;7942.920570794334;7945.801354966172;8022.9598852005365;8032.076311224284;6758.560693554903;6857.417119544794;6866.793996180123;7086.078809754699;7137.464690148156;5032.220005899091;5158.45836187195;5207.2449494823795;5216.191490319006;5217.608679349064;1527.8395768444375;1536.1781446926063;1537.8308386077522;1550.0931954806565;1550.5270892377932;785.5012067337168;788.3299195683737;798.4969469234345;815.0667485728808;820.8604537228686;6073.392660733891;6301.747930082837;6374.521910856704;6410.262819775786;6465.935340646627;921.424109931293;925.6713866577403;945.4091193004373;961.6826447272383;966.3235734985539;4273.615374616299;4573.702709323883;4588;4591.931121033187;4665.766711664403;17583.472495825146;18223.817761822476;18558.72161917572;18610.627787444446;18614.53463663392;18306.908465457855;19299.421017369503;19300.420987370402;19313.710294345598;19372.70940935887;10300.845487317845;10664.093552048163;10734.51694673726;10876.782464350668;10899.400532970603;6916;7309.488335816654;7317.378022868116;7500.512466689648;7534.397248220239;16339.754903676216;16425;16679.416220432227;16718.331266749195;17021.148942552576;16299.837001629832;16519.256633451285;16941.237644306282;17239;17404.216810243317;11134.888651113386;11318;11410.714732131763;11767.11746619024;11767.529298828293;12915.935420323214;13041.934790325988;13112.344382780631;13122.934385328012;13134.868651313747;9715.854262185932;10067.395956242648;10210.234232432746;10246.180305575685;10397.376157430579;10041.096301332915;10097.697069087939;10215.693529194135;10255.384676919408;10421.270511064153;8632;8750.69372571957;8759.386842921189;8764.737057888273;8765.956170219108;5790.913136302875;6079.75049231787;6244.063390491463;6311.621302721851;6377.362263773771;6108.602940808833;6238.563300568917;6272.905906411316;6364.013577895434;6403.199600049994 03:54:06 INFO - PID 26562 | |4;prototype.html;469.2374890802444;495.7199182461909;507.0492825951341;508.92366145078256;518.6810111781256;6021.879562408749;6181;6194.969025154879;6206.193194884664;6247.2815626203;5830.416958304168;5931.377205393425;5955.064604003705;6021.518278537717;6074.301455332638;4859.902801943959;4875.463698993108;4875.804967801301;4924.359833221694;4952.900941981158;4678.368420263272;4881.170201065827;4891.217405215166;4972.403311602613;4990.500949905017;4801.279808028806;4821.30091136785;4893.8287159949405;4894.657373983822;4910.803567857281;4810.87972800681;4830.782614782325;4831.879203019953;4877.146499362633;4880.951190488086;4338.522762496123;4350.521442641307;4363.825446982117;4374.212641724488;4392.560743925614;5933.19901813254;5947.732352044169;5993.820185394445;6062.393760623946;6074.392560743934;5645.040343141676;5645.560382102579;5662.546996240291;5682.715864206814;5685.914711279334;6429.903551446732;6440.194975628046;6495.577787443848;6512.967435162794;6563.671816409208;4820.879478013043;4841.322214889883;4874.610031197496;4880.121578115938;4896.143174944406;6818.352256535622;6855.366655672452;6879.965600172017;6943.479239057091;6963;4923.483034281349;4984.875378115504;5011.774470148852;5017.949820501822;5040.621953353513;4980.477049909779;4998.375203099613;5015.56744978685;5034.974825125924;5045.00544460981;5646.830595082154;5651.463111004448;5660.320761508646;5666.235058267163;5712.400197979152;6452.257990331172;6478.870422591522;6485.784240243879;6533.41199292066;6600.768973085919;1636.860866826333;1659.311385774914;1695.6608678264397;1714.160061569822;1752.3779058434327;1192.9463174157183;1200.9039276858005;1220.6948262934266;1220.798568236249;1227.656256248252;5634.084211577909;5635.69003704792;5679.488846003879;5710.401087695452;5739.971300143556;6422.325655806167;6532.477401807844;6715.764948226789;6721.831954201184;6765.323467653196;5779.537636989031;5787.160861675034;5816.854578635483;5828.358880523139;5857.297124345106;3515.6660117288816;3582.982085089558;3587.1749497615697;3602.225521512835;3619.4751760995036;6417.39034791694;6443.613383197023;6468.838279043061;6516.185476815398;6526.64103474304;6791.592504449749;6826.863462730717;6843.828904277433;6861.176658800976;6891.931080689229;6418.839529011719;6447.742090316335;6478.481721462177;6491.8701625967215;6500.219973603198;6649.60102393858;6688.163979502562;6717.16035495563;6720.764773232913;6724.93275067243;6544.869102618016;6630.9273405843605;6663.26704062543;6675.7997260082275;6702.865942681216;6341.682915854281;6370;6382.6170429774365;6437;6517.706703198272;4901.362822833009;4929.852104436873;4935.432425270996;4982.825601103944;5026.698398096126;6508.511861610304;6590.670466476753;6625.304343044104;6699.765508207384;6702.966485167738;6250.843728906813;6341.714622842075;6373.139626150411;6436.485081193587;6551.312112228338;6371.74513019474;6418.807435776934;6435;6528.183977002875;6535.379138981789;6342.90485642725;6402.679866006588;6437.806865794034;6455.386738259858;6486.962086066207;6371.04434334835;6511.674416279262;6522.771702990372;6543.280239173592;6619.172603424572;6353.68231588428;6362.172917520693;6382.32985536512;6394.4884409246215;6422.807315780534 03:54:06 INFO - PID 26562 | |5;yui.html;889.461875565283;892.9017808041116;913.0869130869131;925.7407925780775;927.7958849053208;17778.466646000623;18715.62568748624;18901.810981890176;18924.90537547312;21743.891280543616;19425.708614370797;20979.685304720442;21005.26481573145;21048.89475552624;21072.367828965154;1022.4121130350042;1042.2652030318607;1043.6347278452556;1049.6011515624052;1050.1283934334483;1052.63157894737;1054.96307629233;1065.8454524094002;1065.9360438373722;1066.4667666166918;1049.2235745548317;1051.1170616681986;1054.6414219165483;1055.0504545908705;1098.0776148035648;1040.4121671255716;1048.570086264628;1049.407084996978;1050.0969166516788;1099.2580008494274;760.3992845651928;762.0436352377786;763.0804880119442;772.6754762999553;809.4333966223667;18202;18619.62760744791;18640.440786776417;18802;18921.81078189214;20454;20747.377578672666;20956.16175352984;21042.894785525976;21211.893940530197;15636.452724154713;15680;15864.603384915354;15932.362705491767;16121.193940302937;3493.68556829884;3546.202104526487;3564.108972756811;3564.2336897567147;3575.1955809942815;114153;118638.40680796541;119963.4001829994;120551.39724301323;121721.78278217193;15685.294161762748;16103.677926441405;16251.756223656655;16309;16430.507084787474;29915.551266731018;29946.850265748533;30009.099727008226;30186.54720179199;30232.395352092833;8244.752657420288;8539.316854651614;8610.698625548075;8625.741227763177;8659.437136586102;4221.598948099926;4281.636060934793;4304.332828411601;4309.461317335333;4319.200947824663;5207.71357575337;5261.342332208474;5328.333958255218;5355.598330125256;5365.892682146336;915.7115508614766;937.1237892570468;944.17856464876;962.1725316228038;964.0793042644258;671.1610486891386;671.3554987212331;687.9793606191822;697.4943166204563;701.3197198717236;10557.31377460478;10979.121670266519;11187.496562654538;12069;12105.33420661872;635.5646382228189;649.9187601549806;663.4393937123124;666.9266380698119;684.0867441964933;5354.705491197944;5407.621466497308;5533.750981205855;5554.861128471821;5985.34161242263;95029;96830.0316996821;99277;101888;103373;84861.57569212238;88571.55714221517;90024;90304;93673;74161.25838741651;77720.61139694379;78263;82263.5886820562;83355.58322208471;11102.167337449562;11251.15616328795;11386;11711.707207319545;12007.579734709243;34415.483767743004;36427.45358819673;36655;36778.26443471062;37027;43441.91352925062;44965.550344496136;45759;46820;47047.76476117734;17735.46793596194;18153.81846181521;18421.723674145167;18554.81445185531;18650.253989840254;20440.693389599466;20448.897755511127;20514.282000129922;20638;20726.896365518678;18317.816821832144;18713.251469941595;18776.342828000954;19068.713969290195;19133.904330478257;18631.81368186355;18774.6245075095;19348;19422;19664.41006769799;18656;18912.52718682044;18944.431667050012;19025.143868525673;19096.522586935436;12818.483622264333;12971.5459958901;13441.395137219044;13522.323883805968;13972.720545589234;12890;12953.740925181255;13796.103253288504;13874.791878122038;14335.856641433453 03:54:06 INFO - PID 26562 | __end_tp_report 03:54:06 INFO - PID 26562 | __start_cc_report 03:54:06 INFO - PID 26562 | _x_x_mozilla_cycle_collect,356 03:54:06 INFO - PID 26562 | __end_cc_report 03:54:06 INFO - PID 26562 | __startTimestamp1501325646875__endTimestamp 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | ------- Summary: start ------- 03:54:06 INFO - PID 26562 | Number of tests: 6 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#0] dojo.html Cycles:165 Average:6137.96 Median:6412.49 stddev:725.74 (11.3%) stddev-sans-first:688.81 03:54:06 INFO - PID 26562 | Values: 3140.3 3143.7 3165.5 3176.8 3199.0 6094.7 6108.4 6158.0 6174.0 6246.7 6177.4 6229.0 6265.1 6301.4 6306.4 5685.7 5722.5 5737.9 5791.2 5813.9 5557.5 5610.7 5638.6 5641.9 5728.1 5657.1 5674.1 5715.4 5720.5 5721.0 5630.1 5687.3 5688.8 5718.5 5719.6 5535.1 5583.3 5651.5 5652.4 5704.7 5962.3 6050.7 6092.6 6094.2 6098.0 6618.6 6638.8 6668.3 6676.6 6683.2 6661.8 6752.4 6757.8 6758.4 6765.8 6179.9 6233.0 6242.8 6247.1 6252.9 6881.6 6918.9 6930.8 6934.9 6944.8 6523.3 6550.9 6573.9 6605.5 6611.3 6614.7 6615.2 6673.9 6753.3 6754.8 6490.5 6594.2 6615.0 6622.5 6688.1 5827.3 6593.7 6632.8 6640.3 6642.8 5418.1 5426.0 5475.0 5492.3 5492.6 4573.1 4612.8 4632.2 4637.5 4664.4 5721.5 5783.7 5793.8 5796.0 5798.4 6774.0 6782.3 6784.4 6786.2 6794.6 5717.8 5818.0 5818.2 5828.0 5843.6 5921.6 5942.6 5943.0 5958.1 5979.7 6421.3 6454.3 6463.4 6547.4 6561.4 6573.5 6702.5 6705.8 6780.5 6795.2 6412.5 6425.0 6428.5 6442.0 6451.5 6536.5 6542.4 6547.3 6551.0 6571.3 5888.5 6678.6 6679.0 6682.4 6803.2 6461.7 6474.9 6569.1 6598.2 6599.8 6383.7 6449.9 6487.9 6590.6 6596.7 6396.2 6443.4 6446.5 6446.6 6472.8 6557.2 6630.8 6637.0 6661.8 6676.2 6344.2 6359.2 6373.6 6443.9 6463.1 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#1] ext.html Cycles:180 Average:39248.73 Median:36499.36 stddev:57826.36 (158.4%) stddev-sans-first:57916.55 03:54:06 INFO - PID 26562 | Values: 808.5 851.3 862.0 889.4 897.2 39977.4 40728.8 40864.0 40919.4 41045.0 36494.5 36504.3 36744.3 36929.6 37023.6 6795.8 6921.4 6935.1 6939.1 6943.1 6811.3 7495.6 7694.2 7698.0 7698.7 7702.0 7710.4 7749.8 7751.5 7753.3 7248.6 7598.7 7808.8 7841.3 7862.3 7642.4 7715.8 7733.8 7739.6 7745.5 37823.4 37921.2 38068.6 38074.6 38239.2 3512.3 3545.5 3547.3 3554.0 3562.9 30989.1 31342.4 31450.1 31518.7 31566.1 4831.3 4842.3 4871.3 4877.1 4885.4 233093.0 234341.0 234891.0 236552.0 236669.8 48723.3 48982.3 49220.0 49275.8 49363.3 51980.5 52081.2 52108.0 52140.7 52152.5 15047.4 15302.3 15359.8 15372.1 15445.1 12365.3 12378.4 12387.1 12395.6 12427.7 14020.5 14035.3 14056.6 14094.2 14145.0 5730.9 5740.6 5816.6 5822.7 5857.0 972.6 989.5 999.3 1025.7 1029.6 21641.7 21672.2 21917.5 22119.6 22223.4 1084.5 1093.2 1117.0 1131.6 1133.8 11224.6 12026.9 12159.9 15556.6 15862.2 230251.0 230719.0 231117.0 232419.0 232448.0 55755.2 56954.7 57805.1 60211.4 60354.0 1497.3 1539.6 1542.4 1544.2 1547.4 26712.5 27635.4 27736.7 27739.6 27807.0 38282.8 38844.0 38903.0 39006.4 39039.0 199280.0 199819.0 200172.0 200177.0 200242.0 34398.0 35935.0 36342.0 36785.8 36806.3 44446.6 45569.0 45675.0 45750.0 46121.0 30032.5 30325.4 32236.5 32423.5 33032.2 32127.7 32434.4 32751.5 33259.8 33374.3 38067.8 38070.2 38219.0 38398.8 38477.8 30273.8 32846.5 33054.5 33301.3 34220.3 23468.3 23515.5 23726.2 23729.0 24020.5 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#2] jquery.html Cycles:180 Average:35988.49 Median:21851.12 stddev:82213.86 (376.2%) stddev-sans-first:82401.45 03:54:06 INFO - PID 26562 | Values: 554.9 556.9 562.4 566.6 581.2 21432.4 22269.9 22297.8 22300.2 22363.0 25876.4 26193.9 26327.7 26387.1 26556.6 6492.4 6657.3 6658.3 6659.8 6659.9 6273.7 6513.2 6590.6 6845.6 6847.7 6864.3 6864.9 6865.7 6866.4 6868.7 6814.4 6815.3 6816.8 6855.9 6873.7 6707.3 6709.5 6715.9 6716.9 6743.2 29748.7 31521.4 32205.7 32312.7 32409.7 1867.9 1909.4 1924.5 1924.8 1931.6 20053.5 20320.9 21265.4 21276.3 21368.5 2455.6 2481.1 2520.8 2523.8 2539.9 135440.0 143445.0 143794.3 143898.0 144108.3 20807.5 20823.7 22569.4 22954.9 22974.8 44135.0 44149.0 44259.0 44563.1 44627.1 11839.2 11852.5 12076.8 12181.8 12288.6 10133.2 10214.5 10221.5 10302.9 10369.4 9538.9 11143.4 11525.3 11534.4 11714.5 3690.9 4164.6 4294.3 4356.2 4377.2 923.1 938.5 939.2 959.3 965.9 18318.1 18923.2 18984.5 18989.4 19447.7 985.0 1025.1 1028.6 1048.6 1054.0 10648.8 10877.7 10988.9 11042.6 11393.9 481525.0 483760.0 484511.0 490998.0 492815.0 114886.4 118195.4 121639.0 122470.0 123105.4 1237.6 1246.7 1261.1 1270.5 1272.6 17162.7 17266.7 17523.5 17555.1 17967.9 50005.2 51947.7 52440.0 52822.0 54334.7 73530.0 73613.6 74122.3 74477.0 74672.0 14518.4 14653.6 14682.9 14732.9 14822.8 22688.5 23167.2 23541.6 23696.3 24017.2 18213.4 18241.4 18316.8 18339.9 18414.1 14956.7 15400.7 16134.4 16209.0 16731.7 18900.7 18904.2 20120.8 20326.6 20368.0 14823.4 15002.7 15021.5 15034.3 15085.3 18971.2 19013.4 19028.1 19304.4 19373.1 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#3] mootools.html Cycles:180 Average:8473.16 Median:2627.49 stddev:5812.37 (221.2%) stddev-sans-first:5803.73 03:54:06 INFO - PID 26562 | Values: 1306.5 1332.8 1359.4 1364.3 1370.3 13284.4 13838.4 13905.4 13923.1 13931.6 14398.6 14654.9 14657.4 14662.0 14662.2 2617.9 2650.1 2653.2 2658.6 2660.1 2515.0 2580.1 2615.6 2726.1 2731.1 2723.8 2738.7 2759.9 2765.4 2775.7 2578.5 2591.7 2655.3 2656.5 2662.6 2604.1 2637.1 2637.8 2655.3 2663.1 13572.9 13680.7 13688.6 13738.7 13741.5 7529.8 7817.8 7842.0 7862.8 7865.9 4934.3 5094.3 5242.1 5256.1 5258.5 1726.3 1802.5 1805.5 1835.4 1850.1 20064.6 22428.6 22604.8 22655.4 22678.4 5892.6 6539.1 6767.7 6779.3 6780.0 15657.6 15677.7 15727.0 15747.7 15764.7 7778.6 7942.9 7945.8 8023.0 8032.1 6758.6 6857.4 6866.8 7086.1 7137.5 5032.2 5158.5 5207.2 5216.2 5217.6 1527.8 1536.2 1537.8 1550.1 1550.5 785.5 788.3 798.5 815.1 820.9 6073.4 6301.7 6374.5 6410.3 6465.9 921.4 925.7 945.4 961.7 966.3 4273.6 4573.7 4588.0 4591.9 4665.8 17583.5 18223.8 18558.7 18610.6 18614.5 18306.9 19299.4 19300.4 19313.7 19372.7 10300.8 10664.1 10734.5 10876.8 10899.4 6916.0 7309.5 7317.4 7500.5 7534.4 16339.8 16425.0 16679.4 16718.3 17021.1 16299.8 16519.3 16941.2 17239.0 17404.2 11134.9 11318.0 11410.7 11767.1 11767.5 12915.9 13041.9 13112.3 13122.9 13134.9 9715.9 10067.4 10210.2 10246.2 10397.4 10041.1 10097.7 10215.7 10255.4 10421.3 8632.0 8750.7 8759.4 8764.7 8766.0 5790.9 6079.8 6244.1 6311.6 6377.4 6108.6 6238.6 6272.9 6364.0 6403.2 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#4] prototype.html Cycles:180 Average:5457.96 Median:6007.67 stddev:1539.92 (25.6%) stddev-sans-first:1498.02 03:54:06 INFO - PID 26562 | Values: 469.2 495.7 507.0 508.9 518.7 6021.9 6181.0 6195.0 6206.2 6247.3 5830.4 5931.4 5955.1 6021.5 6074.3 4859.9 4875.5 4875.8 4924.4 4952.9 4678.4 4881.2 4891.2 4972.4 4990.5 4801.3 4821.3 4893.8 4894.7 4910.8 4810.9 4830.8 4831.9 4877.1 4881.0 4338.5 4350.5 4363.8 4374.2 4392.6 5933.2 5947.7 5993.8 6062.4 6074.4 5645.0 5645.6 5662.5 5682.7 5685.9 6429.9 6440.2 6495.6 6513.0 6563.7 4820.9 4841.3 4874.6 4880.1 4896.1 6818.4 6855.4 6880.0 6943.5 6963.0 4923.5 4984.9 5011.8 5017.9 5040.6 4980.5 4998.4 5015.6 5035.0 5045.0 5646.8 5651.5 5660.3 5666.2 5712.4 6452.3 6478.9 6485.8 6533.4 6600.8 1636.9 1659.3 1695.7 1714.2 1752.4 1192.9 1200.9 1220.7 1220.8 1227.7 5634.1 5635.7 5679.5 5710.4 5740.0 6422.3 6532.5 6715.8 6721.8 6765.3 5779.5 5787.2 5816.9 5828.4 5857.3 3515.7 3583.0 3587.2 3602.2 3619.5 6417.4 6443.6 6468.8 6516.2 6526.6 6791.6 6826.9 6843.8 6861.2 6891.9 6418.8 6447.7 6478.5 6491.9 6500.2 6649.6 6688.2 6717.2 6720.8 6724.9 6544.9 6630.9 6663.3 6675.8 6702.9 6341.7 6370.0 6382.6 6437.0 6517.7 4901.4 4929.9 4935.4 4982.8 5026.7 6508.5 6590.7 6625.3 6699.8 6703.0 6250.8 6341.7 6373.1 6436.5 6551.3 6371.7 6418.8 6435.0 6528.2 6535.4 6342.9 6402.7 6437.8 6455.4 6487.0 6371.0 6511.7 6522.8 6543.3 6619.2 6353.7 6362.2 6382.3 6394.5 6422.8 03:54:06 INFO - PID 26562 | 03:54:06 INFO - PID 26562 | [#5] yui.html Cycles:180 Average:21979.77 Median:20576.14 stddev:28931.00 (140.6%) stddev-sans-first:28968.82 03:54:06 INFO - PID 26562 | Values: 889.5 892.9 913.1 925.7 927.8 17778.5 18715.6 18901.8 18924.9 21743.9 19425.7 20979.7 21005.3 21048.9 21072.4 1022.4 1042.3 1043.6 1049.6 1050.1 1052.6 1055.0 1065.8 1065.9 1066.5 1049.2 1051.1 1054.6 1055.1 1098.1 1040.4 1048.6 1049.4 1050.1 1099.3 760.4 762.0 763.1 772.7 809.4 18202.0 18619.6 18640.4 18802.0 18921.8 20454.0 20747.4 20956.2 21042.9 21211.9 15636.5 15680.0 15864.6 15932.4 16121.2 3493.7 3546.2 3564.1 3564.2 3575.2 114153.0 118638.4 119963.4 120551.4 121721.8 15685.3 16103.7 16251.8 16309.0 16430.5 29915.6 29946.9 30009.1 30186.5 30232.4 8244.8 8539.3 8610.7 8625.7 8659.4 4221.6 4281.6 4304.3 4309.5 4319.2 5207.7 5261.3 5328.3 5355.6 5365.9 915.7 937.1 944.2 962.2 964.1 671.2 671.4 688.0 697.5 701.3 10557.3 10979.1 11187.5 12069.0 12105.3 635.6 649.9 663.4 666.9 684.1 5354.7 5407.6 5533.8 5554.9 5985.3 95029.0 96830.0 99277.0 101888.0 103373.0 84861.6 88571.6 90024.0 90304.0 93673.0 74161.3 77720.6 78263.0 82263.6 83355.6 11102.2 11251.2 11386.0 11711.7 12007.6 34415.5 36427.5 36655.0 36778.3 37027.0 43441.9 44965.6 45759.0 46820.0 47047.8 17735.5 18153.8 18421.7 18554.8 18650.3 20440.7 20448.9 20514.3 20638.0 20726.9 18317.8 18713.3 18776.3 19068.7 19133.9 18631.8 18774.6 19348.0 19422.0 19664.4 18656.0 18912.5 18944.4 19025.1 19096.5 12818.5 12971.5 13441.4 13522.3 13972.7 12890.0 12953.7 13796.1 13874.8 14335.9 03:54:06 INFO - PID 26562 | -------- Summary: end -------- 03:54:06 INFO - PID 26562 | 03:54:07 INFO - TEST-INFO | 26562: exit 0 03:54:07 INFO - TEST-OK | dromaeo_css | took 1113911ms 03:54:07 INFO - TEST-START | kraken 03:54:07 INFO - Initialising browser for kraken test... 03:54:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51057/getInfo.html -profile /tmp/tmpcFveAT/profile 03:54:07 INFO - TEST-INFO | started process 26932 (/builds/slave/test/build/application/firefox/firefox http://localhost:51057/getInfo.html) 03:54:13 INFO - TEST-INFO | 26932: exit 0 03:54:13 INFO - Browser initialized. 03:54:13 INFO - Running cycle 1/1 for kraken test... 03:54:13 INFO - TEST-INFO | started process 27157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcFveAT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:14 INFO - PID 27157 | 03:54:14 INFO - PID 27157 | (/builds/slave/test/build/application/firefox/firefox:27212): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:14 INFO - PID 27157 | 03:54:25 INFO - PID 27157 | RSS: Main: 173633536 03:54:25 INFO - PID 27157 | 03:54:27 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:28 INFO - PID 27157 | RSS: Main: 178724864 03:54:28 INFO - PID 27157 | 03:54:31 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-dft) 03:54:32 INFO - PID 27157 | RSS: Main: 178913280 03:54:32 INFO - PID 27157 | 03:54:35 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-fft) 03:54:35 INFO - PID 27157 | RSS: Main: 173740032 03:54:35 INFO - PID 27157 | 03:54:38 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51057/tests/kraken/driver.html?testName=audio-oscillator) 03:54:38 INFO - PID 27157 | RSS: Main: 174370816 03:54:38 INFO - PID 27157 | 03:54:40 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:41 INFO - PID 27157 | RSS: Main: 174415872 03:54:41 INFO - PID 27157 | 03:54:44 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:45 INFO - PID 27157 | RSS: Main: 176996352 03:54:45 INFO - PID 27157 | 03:54:48 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51057/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:49 INFO - PID 27157 | RSS: Main: 176545792 03:54:49 INFO - PID 27157 | 03:54:52 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51057/tests/kraken/driver.html?testName=json-parse-financial) 03:54:53 INFO - PID 27157 | RSS: Main: 177471488 03:54:53 INFO - PID 27157 | 03:54:54 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:55 INFO - PID 27157 | RSS: Main: 177274880 03:54:55 INFO - PID 27157 | 03:54:57 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:57 INFO - PID 27157 | RSS: Main: 174493696 03:54:57 INFO - PID 27157 | 03:55:00 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:00 INFO - PID 27157 | RSS: Main: 174522368 03:55:00 INFO - PID 27157 | 03:55:03 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:04 INFO - PID 27157 | RSS: Main: 174796800 03:55:04 INFO - PID 27157 | 03:55:07 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:08 INFO - PID 27157 | RSS: Main: 174702592 03:55:08 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | Cycle 1(1): loaded http://localhost:51057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51057/tests/kraken/driver.html?testName=ai-astar) 03:55:10 INFO - PID 27157 | RSS: Main: 176484352 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | __start_tp_report 03:55:10 INFO - PID 27157 | _x_x_mozilla_page_load 03:55:10 INFO - PID 27157 | _x_x_mozilla_page_load_details 03:55:10 INFO - PID 27157 | |i|pagename|runs| 03:55:10 INFO - PID 27157 | |0;ai-astar;100;107;102;115;116;108;113;100;113;113 03:55:10 INFO - PID 27157 | |1;audio-beat-detection;147;118;140;174;118;156;150;118;165;121 03:55:10 INFO - PID 27157 | |2;audio-dft;162;163;161;163;169;168;165;166;163;164 03:55:10 INFO - PID 27157 | |3;audio-fft;75;75;76;177;76;76;74;75;178;75 03:55:10 INFO - PID 27157 | |4;audio-oscillator;79;79;137;78;78;79;124;86;79;134 03:55:10 INFO - PID 27157 | |5;imaging-gaussian-blur;114;114;114;114;114;117;114;114;114;116 03:55:10 INFO - PID 27157 | |6;imaging-darkroom;151;150;150;150;151;150;152;153;149;152 03:55:10 INFO - PID 27157 | |7;imaging-desaturate;94;94;94;93;94;93;94;94;94;95 03:55:10 INFO - PID 27157 | |8;json-parse-financial;56;57;57;56;55;55;58;59;54;55 03:55:10 INFO - PID 27157 | |9;json-stringify-tinderbox;65;64;54;55;64;59;55;66;54;54 03:55:10 INFO - PID 27157 | |10;stanford-crypto-aes;86;83;81;81;88;83;81;81;84;78 03:55:10 INFO - PID 27157 | |11;stanford-crypto-ccm;133;130;134;146;134;130;127;128;126;167 03:55:10 INFO - PID 27157 | |12;stanford-crypto-pbkdf2;186;185;192;184;190;178;182;197;188;195 03:55:10 INFO - PID 27157 | |13;stanford-crypto-sha256-iterative;70;67;70;67;68;68;67;67;68;75 03:55:10 INFO - PID 27157 | __end_tp_report 03:55:10 INFO - PID 27157 | __start_cc_report 03:55:10 INFO - PID 27157 | _x_x_mozilla_cycle_collect,982 03:55:10 INFO - PID 27157 | __end_cc_report 03:55:10 INFO - PID 27157 | __startTimestamp1501325710304__endTimestamp 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | ------- Summary: start ------- 03:55:10 INFO - PID 27157 | Number of tests: 14 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#0] ai-astar Cycles:10 Average:108.70 Median:113.00 stddev:6.22 (5.5%) stddev-sans-first:5.74 03:55:10 INFO - PID 27157 | Values: 100.0 107.0 102.0 115.0 116.0 108.0 113.0 100.0 113.0 113.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:148.50 stddev:21.07 (14.2%) stddev-sans-first:22.22 03:55:10 INFO - PID 27157 | Values: 147.0 118.0 140.0 174.0 118.0 156.0 150.0 118.0 165.0 121.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.59 (1.6%) stddev-sans-first:2.60 03:55:10 INFO - PID 27157 | Values: 162.0 163.0 161.0 163.0 169.0 168.0 165.0 166.0 163.0 164.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.00 stddev:43.12 (57.5%) stddev-sans-first:45.08 03:55:10 INFO - PID 27157 | Values: 75.0 75.0 76.0 177.0 76.0 76.0 74.0 75.0 178.0 75.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.00 stddev:25.40 (32.2%) stddev-sans-first:26.25 03:55:10 INFO - PID 27157 | Values: 79.0 79.0 137.0 78.0 78.0 79.0 124.0 86.0 79.0 134.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 03:55:10 INFO - PID 27157 | Values: 114.0 114.0 114.0 114.0 114.0 117.0 114.0 114.0 114.0 116.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 03:55:10 INFO - PID 27157 | Values: 151.0 150.0 150.0 150.0 151.0 150.0 152.0 153.0 149.0 152.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:55:10 INFO - PID 27157 | Values: 94.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 95.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.64 03:55:10 INFO - PID 27157 | Values: 56.0 57.0 57.0 56.0 55.0 55.0 58.0 59.0 54.0 55.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:61.50 stddev:5.19 (8.4%) stddev-sans-first:5.02 03:55:10 INFO - PID 27157 | Values: 65.0 64.0 54.0 55.0 64.0 59.0 55.0 66.0 54.0 54.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:2.88 (3.5%) stddev-sans-first:2.77 03:55:10 INFO - PID 27157 | Values: 86.0 83.0 81.0 81.0 88.0 83.0 81.0 81.0 84.0 78.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:133.50 stddev:12.44 (9.3%) stddev-sans-first:13.16 03:55:10 INFO - PID 27157 | Values: 133.0 130.0 134.0 146.0 134.0 130.0 127.0 128.0 126.0 167.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:189.00 stddev:5.91 (3.1%) stddev-sans-first:6.23 03:55:10 INFO - PID 27157 | Values: 186.0 185.0 192.0 184.0 190.0 178.0 182.0 197.0 188.0 195.0 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:2.50 (3.7%) stddev-sans-first:2.60 03:55:10 INFO - PID 27157 | Values: 70.0 67.0 70.0 67.0 68.0 68.0 67.0 67.0 68.0 75.0 03:55:10 INFO - PID 27157 | -------- Summary: end -------- 03:55:10 INFO - PID 27157 | 03:55:10 INFO - PID 27157 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:10 INFO - TEST-INFO | 27157: exit 0 03:55:11 INFO - TEST-OK | kraken | took 63450ms 03:55:11 INFO - SUITE-END | took 1177s 03:55:11 INFO - Completed test suite (00:19:37) 03:55:11 INFO - javascript benchmark 03:55:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8477.05409949301, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.3248301615163, 3143.669914658961, 3165.4776961801304, 3176.8093914365127, 3198.968010319896, 6094.725737341825, 6108.389161083889, 6158.045502947045, 6174.0, 6246.718897649605, 6177.351378105302, 6229.0, 6265.060240963846, 6301.401366870152, 6306.369363063703, 5685.658860468375, 5722.54219662426, 5737.856553586152, 5791.160281759142, 5813.912791308134, 5557.527610153142, 5610.69141197234, 5638.633488823234, 5641.858953526174, 5728.112142617901, 5657.066584013633, 5674.0637794764025, 5715.3998830122655, 5720.456556627114, 5720.971395143039, 5630.127330263775, 5687.260656114679, 5688.772449102031, 5718.513926316226, 5719.628224165416, 5535.114381698949, 5583.3300003999375, 5651.4913657770585, 5652.406497317805, 5704.743286552115, 5962.34414214436, 6050.69746512677, 6092.603980741282, 6094.177286066369, 6097.993831017877, 6618.602883826938, 6638.800835974928, 6668.333166683341, 6676.632785196813, 6683.198016238082, 6661.833454163685, 6752.426043786235, 6757.797266082025, 6758.425533829631, 6765.763198288037, 6179.876402471926, 6233.0, 6242.843928901813, 6247.125402443661, 6252.874942501125, 6881.621510816853, 6918.8616227676175, 6930.792076237721, 6934.861302773917, 6944.826379340557, 6523.315051919575, 6550.901736473957, 6573.934260657428, 6605.504587155982, 6611.272759996396, 6614.669266536654, 6615.206175259, 6673.866522669617, 6753.257141714407, 6754.797356079325, 6490.545661803629, 6594.241662208811, 6615.007748837713, 6622.536422450478, 6688.097106890507, 5827.301172185153, 6593.736250549924, 6632.767853125118, 6640.335966403321, 6642.833929151713, 5418.078926582411, 5426.0, 5475.0, 5492.258545096361, 5492.642978206404, 4573.085382923428, 4612.769361531977, 4632.166210082218, 4637.5130611286, 4664.440267167962, 5721.542276617861, 5783.652980821164, 5793.797217097382, 5796.0, 5798.420157984167, 6773.966130169416, 6782.287859774751, 6784.3894049535775, 6786.185657721105, 6794.558353706993, 5717.799877004285, 5818.040023396177, 5818.185454036354, 5828.0, 5843.590948633555, 5921.555883308769, 5942.554308426799, 5942.970285148546, 5958.076498142795, 5979.730912108966, 6421.325760795236, 6454.32229615893, 6463.385978332051, 6547.443467305237, 6561.376669216513, 6573.506986976092, 6702.497312701665, 6705.798826035227, 6780.491463140185, 6795.218549866631, 6412.487001039999, 6424.967875160594, 6428.517861160525, 6442.033694945796, 6451.451626611791, 6536.477081833537, 6542.411182993554, 6547.279799222177, 6550.967245163743, 6571.342865713582, 5888.499477544286, 6678.599284042973, 6679.0, 6682.365175308338, 6803.183617965876, 6461.676916154268, 6474.870502590016, 6569.080328753883, 6598.175228096488, 6599.769008084694, 6383.6808159592765, 6449.871002580016, 6487.9026814598765, 6590.637514936724, 6596.670166491752, 6396.200474940632, 6443.355664433519, 6446.484281257394, 6446.645434501147, 6472.805815825533, 6557.245916719638, 6630.7679231226675, 6637.037629543785, 6661.766838160641, 6676.198856137295, 6344.238691357066, 6359.236891573041, 6373.5857169283845, 6443.871122577429, 6463.127477790438], "value": 6084.094662609306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5431731071944, 851.3019324154196, 861.9525926074066, 889.3996552327179, 897.1925267259465, 39977.4003389949, 40728.79635601818, 40864.0, 40919.38620920689, 41045.0, 36494.45258321127, 36504.269914601755, 36744.26511469769, 36929.63070369302, 37023.62976370235, 6795.7621483248095, 6921.411680007205, 6935.063766391523, 6939.063226464438, 6943.062686537303, 6811.318868113199, 7495.587742674151, 7694.192109828471, 7698.0, 7698.653560589787, 7701.9614901925415, 7710.421718371116, 7749.845003099935, 7751.534907905516, 7753.340966017867, 7248.601326927043, 7598.696052157907, 7808.804779880492, 7841.294283514454, 7862.331701805382, 7642.388608911329, 7715.845683086307, 7733.7679869604, 7739.57432341221, 7745.535267883945, 37823.432648510294, 37921.241575168344, 38068.61931380678, 38074.61925380738, 38239.235215295535, 3512.2799826035603, 3545.468179773029, 3547.2728090741334, 3553.9693488888192, 3562.91092722684, 30989.0703278902, 31342.43287835599, 31450.056498305086, 31518.684813152035, 31566.053018409486, 4831.347768051303, 4842.322074909515, 4871.342368780205, 4877.122118018755, 4885.36490256268, 233093.0, 234341.0, 234891.0, 236552.0, 236669.81665091738, 48723.26915096276, 48982.26526602104, 49220.0, 49275.75362123166, 49363.25955110676, 51980.48019519832, 52081.21878171831, 52108.0, 52140.73929630403, 52152.478475215525, 15047.398104075713, 15302.311395987208, 15359.846401536066, 15372.077675339515, 15445.0732956023, 12365.319907404999, 12378.44297006637, 12387.07096967731, 12395.566155184526, 12427.689307767378, 14020.509282175075, 14035.298235088205, 14056.578302650936, 14094.154350738783, 14145.0, 5730.856728581735, 5740.6268592541355, 5816.563757718188, 5822.679752613647, 5856.970715146397, 972.5817898303656, 989.5398639632606, 999.2605471950704, 1025.6717850287837, 1029.577873072037, 21641.675374869388, 21672.241471548736, 21917.452063698216, 22119.557608847732, 22223.44441388978, 1084.4848696869083, 1093.1691914145306, 1116.983245251322, 1131.5643477261315, 1133.8412622232895, 11224.551017959353, 12026.879731202576, 12159.878401216052, 15556.611084722746, 15862.206889655472, 230251.0, 230719.0, 231117.0, 232419.0, 232448.0, 55755.16367254494, 56954.7152264236, 57805.13292300619, 60211.39788602058, 60354.0, 1497.2588568658584, 1539.638185026518, 1542.4447199008348, 1544.1744548286604, 1547.4274518428253, 26712.53081080559, 27635.44729105447, 27736.72263277422, 27739.583906241827, 27807.0, 38282.80858595689, 38844.0, 38903.0, 39006.41490377703, 39039.0, 199280.0, 199819.0, 200172.0, 200177.0, 200242.0, 34398.0, 35935.0, 36342.0, 36785.81607091947, 36806.26387472289, 44446.55553444424, 45569.0, 45675.0, 45750.0, 46121.0, 30032.549511756904, 30325.393492130475, 32236.516452253705, 32423.513647295782, 33032.174195645304, 32127.67872321247, 32434.351312973136, 32751.508727369586, 33259.83370083134, 33374.332513350084, 38067.80966095152, 38070.2385952285, 38219.0, 38398.80800595979, 38477.80761096177, 30273.848630756704, 32846.507302390004, 33054.5041824368, 33301.333973320885, 34220.31559368849, 23468.295951121494, 23515.52968940646, 23726.169584065166, 23729.0, 24020.51958960776], "value": 17365.835535662256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.869605642674, 556.9387367389589, 562.4488001758278, 566.5920537213208, 581.1631250998562, 21432.357029289127, 22269.888650556746, 22297.77362245078, 22300.21949231777, 22363.0, 25876.35309117273, 26193.86903065482, 26327.736722632817, 26387.076452324174, 26556.6016509752, 6492.3832235937625, 6657.334266573353, 6658.267590565034, 6659.800205993828, 6659.9001014984815, 6273.654948977827, 6513.153290072284, 6590.571612845174, 6845.555038922479, 6847.657617119125, 6864.347886950732, 6864.931350686479, 6865.725370985155, 6866.416354609864, 6868.656567171646, 6814.352636499525, 6815.250322464525, 6816.7614133505585, 6855.862882742342, 6873.725050997954, 6707.295733947963, 6709.463242940553, 6715.899261511081, 6716.865662686719, 6743.15710536183, 29748.70251297481, 31521.369572608648, 32205.677943220737, 32312.6768732312, 32409.67590324114, 1867.9252829886789, 1909.3794516782102, 1924.5188702824294, 1924.7594050743658, 1931.565397785501, 20053.498662533406, 20320.898395508077, 21265.36203913885, 21276.255331063494, 21368.46578835526, 2455.588036878784, 2481.10680155144, 2520.785733212679, 2523.8485690858606, 2539.885705143273, 135440.0, 143445.0, 143794.28102859523, 143898.0, 144108.2794586031, 20807.479813004797, 20823.687644685342, 22569.4357641057, 22954.885225573766, 22974.770252297596, 44135.0, 44149.0, 44259.0, 44563.10873782506, 44627.10745785066, 11839.17125801203, 11852.466639001266, 12076.75846483083, 12181.756364872654, 12288.569900053633, 10133.240006999504, 10214.489275536194, 10221.488925553693, 10302.896971030345, 10369.377837329785, 9538.904610953941, 11143.442827858575, 11525.308481491138, 11534.365609891369, 11714.472848721827, 3690.8523659053876, 4164.6251837334785, 4294.291441912112, 4356.23572453157, 4377.190219809346, 923.132255679659, 938.5448057692014, 939.1735272959752, 959.2757468111531, 965.8647789309503, 18318.08409579516, 18923.243070277036, 18984.525386865163, 18989.430317090508, 19447.708284375745, 984.9510271560765, 1025.1183981775666, 1028.5782829040058, 1048.6487026846091, 1054.0, 10648.840267395995, 10877.67366978992, 10988.945055274673, 11042.558297668164, 11393.886061139448, 481525.0, 483760.0, 484511.0, 490998.0, 492815.0, 114886.4255678733, 118195.40902295434, 121639.0, 122470.0, 123105.38447307707, 1237.6287113865985, 1246.6571692784376, 1261.0920137500984, 1270.5235536673747, 1272.5991312736458, 17162.742558861377, 17266.65466690634, 17523.474295771146, 17555.133780680262, 17967.910160449115, 50005.249921250484, 51947.701307467614, 52440.0, 52822.0, 54334.7283263597, 73530.0, 73613.63193183999, 74122.25877741154, 74477.0, 74672.0, 14518.419263229353, 14653.63365915818, 14682.853171468576, 14732.852671473149, 14822.77765833535, 22688.546229075655, 23167.189148379726, 23541.64687529654, 23696.28911132669, 24017.159399420936, 18213.362532311305, 18241.361552345603, 18316.81683183151, 18339.908300458414, 18414.079296034877, 14956.700865982837, 15400.691986160438, 16134.354625814836, 16209.0, 16731.74902376441, 18900.716489252398, 18904.243830246636, 20120.798792011894, 20326.59346813026, 20368.0, 14823.40706371733, 15002.699946001238, 15021.474248401692, 15034.32345544475, 15085.321160547583, 18971.241150354384, 19013.42959711211, 19028.143733532303, 19304.420867374, 19373.128209230337], "value": 12762.872155179983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.4839388441562, 1332.7934170203616, 1359.354306704315, 1364.270115488214, 1370.3490841850119, 13284.402201900913, 13838.377273022714, 13905.374258158381, 13923.094998825069, 13931.582052538415, 14398.568042958701, 14654.926725366358, 14657.41370345185, 14662.0, 14662.193579353132, 2617.908373206938, 2650.0857204264594, 2653.2040387883653, 2658.601209818533, 2660.0955675070472, 2514.962275565868, 2580.109862097573, 2615.581506958887, 2726.1003868723274, 2731.0714357118577, 2723.836569805818, 2738.657667791526, 2759.9448011039767, 2765.4192619549917, 2775.680796708374, 2578.510083084208, 2591.7019542752637, 2655.2698008047746, 2656.481986012728, 2662.6405435266283, 2604.0885690008536, 2637.07702304192, 2637.8261673555276, 2655.309619498925, 2663.1477927063347, 13572.864271357259, 13680.65798355049, 13688.589342319747, 13738.725225495535, 13741.519046833413, 7529.8117547061765, 7817.765467035998, 7842.0, 7862.76411707644, 7865.882011769828, 4934.3338649282605, 5094.286799848024, 5242.13504771716, 5256.106461901486, 5258.474152584749, 1726.326732574297, 1802.4502526729343, 1805.4944615507547, 1835.3943198744382, 1850.1396850464464, 20064.59870802576, 22428.55142897133, 22604.77395226043, 22655.433614159778, 22678.433039173986, 5892.616979896293, 6539.117219175446, 6767.72929082841, 6779.2881747416795, 6779.966100169468, 15657.60855978587, 15677.686446271011, 15727.0, 15747.68504629901, 15764.68470630581, 7778.572178530122, 7942.920570794334, 7945.801354966172, 8022.9598852005365, 8032.076311224284, 6758.560693554903, 6857.417119544794, 6866.793996180123, 7086.078809754699, 7137.464690148156, 5032.220005899091, 5158.45836187195, 5207.2449494823795, 5216.191490319006, 5217.608679349064, 1527.8395768444375, 1536.1781446926063, 1537.8308386077522, 1550.0931954806565, 1550.5270892377932, 785.5012067337168, 788.3299195683737, 798.4969469234345, 815.0667485728808, 820.8604537228686, 6073.392660733891, 6301.747930082837, 6374.521910856704, 6410.262819775786, 6465.935340646627, 921.424109931293, 925.6713866577403, 945.4091193004373, 961.6826447272383, 966.3235734985539, 4273.615374616299, 4573.702709323883, 4588.0, 4591.931121033187, 4665.766711664403, 17583.472495825146, 18223.817761822476, 18558.72161917572, 18610.627787444446, 18614.53463663392, 18306.908465457855, 19299.421017369503, 19300.420987370402, 19313.710294345598, 19372.70940935887, 10300.845487317845, 10664.093552048163, 10734.51694673726, 10876.782464350668, 10899.400532970603, 6916.0, 7309.488335816654, 7317.378022868116, 7500.512466689648, 7534.397248220239, 16339.754903676216, 16425.0, 16679.416220432227, 16718.331266749195, 17021.148942552576, 16299.837001629832, 16519.256633451285, 16941.237644306282, 17239.0, 17404.216810243317, 11134.888651113386, 11318.0, 11410.714732131763, 11767.11746619024, 11767.529298828293, 12915.935420323214, 13041.934790325988, 13112.344382780631, 13122.934385328012, 13134.868651313747, 9715.854262185932, 10067.395956242648, 10210.234232432746, 10246.180305575685, 10397.376157430579, 10041.096301332915, 10097.697069087939, 10215.693529194135, 10255.384676919408, 10421.270511064153, 8632.0, 8750.69372571957, 8759.386842921189, 8764.737057888273, 8765.956170219108, 5790.913136302875, 6079.75049231787, 6244.063390491463, 6311.621302721851, 6377.362263773771, 6108.602940808833, 6238.563300568917, 6272.905906411316, 6364.013577895434, 6403.199600049994], "value": 6188.216357414745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.2374890802444, 495.7199182461909, 507.0492825951341, 508.92366145078256, 518.6810111781256, 6021.879562408749, 6181.0, 6194.969025154879, 6206.193194884664, 6247.2815626203, 5830.416958304168, 5931.377205393425, 5955.064604003705, 6021.518278537717, 6074.301455332638, 4859.902801943959, 4875.463698993108, 4875.804967801301, 4924.359833221694, 4952.900941981158, 4678.368420263272, 4881.170201065827, 4891.217405215166, 4972.403311602613, 4990.500949905017, 4801.279808028806, 4821.30091136785, 4893.8287159949405, 4894.657373983822, 4910.803567857281, 4810.87972800681, 4830.782614782325, 4831.879203019953, 4877.146499362633, 4880.951190488086, 4338.522762496123, 4350.521442641307, 4363.825446982117, 4374.212641724488, 4392.560743925614, 5933.19901813254, 5947.732352044169, 5993.820185394445, 6062.393760623946, 6074.392560743934, 5645.040343141676, 5645.560382102579, 5662.546996240291, 5682.715864206814, 5685.914711279334, 6429.903551446732, 6440.194975628046, 6495.577787443848, 6512.967435162794, 6563.671816409208, 4820.879478013043, 4841.322214889883, 4874.610031197496, 4880.121578115938, 4896.143174944406, 6818.352256535622, 6855.366655672452, 6879.965600172017, 6943.479239057091, 6963.0, 4923.483034281349, 4984.875378115504, 5011.774470148852, 5017.949820501822, 5040.621953353513, 4980.477049909779, 4998.375203099613, 5015.56744978685, 5034.974825125924, 5045.00544460981, 5646.830595082154, 5651.463111004448, 5660.320761508646, 5666.235058267163, 5712.400197979152, 6452.257990331172, 6478.870422591522, 6485.784240243879, 6533.41199292066, 6600.768973085919, 1636.860866826333, 1659.311385774914, 1695.6608678264397, 1714.160061569822, 1752.3779058434327, 1192.9463174157183, 1200.9039276858005, 1220.6948262934266, 1220.798568236249, 1227.656256248252, 5634.084211577909, 5635.69003704792, 5679.488846003879, 5710.401087695452, 5739.971300143556, 6422.325655806167, 6532.477401807844, 6715.764948226789, 6721.831954201184, 6765.323467653196, 5779.537636989031, 5787.160861675034, 5816.854578635483, 5828.358880523139, 5857.297124345106, 3515.6660117288816, 3582.982085089558, 3587.1749497615697, 3602.225521512835, 3619.4751760995036, 6417.39034791694, 6443.613383197023, 6468.838279043061, 6516.185476815398, 6526.64103474304, 6791.592504449749, 6826.863462730717, 6843.828904277433, 6861.176658800976, 6891.931080689229, 6418.839529011719, 6447.742090316335, 6478.481721462177, 6491.8701625967215, 6500.219973603198, 6649.60102393858, 6688.163979502562, 6717.16035495563, 6720.764773232913, 6724.93275067243, 6544.869102618016, 6630.9273405843605, 6663.26704062543, 6675.7997260082275, 6702.865942681216, 6341.682915854281, 6370.0, 6382.6170429774365, 6437.0, 6517.706703198272, 4901.362822833009, 4929.852104436873, 4935.432425270996, 4982.825601103944, 5026.698398096126, 6508.511861610304, 6590.670466476753, 6625.304343044104, 6699.765508207384, 6702.966485167738, 6250.843728906813, 6341.714622842075, 6373.139626150411, 6436.485081193587, 6551.312112228338, 6371.74513019474, 6418.807435776934, 6435.0, 6528.183977002875, 6535.379138981789, 6342.90485642725, 6402.679866006588, 6437.806865794034, 6455.386738259858, 6486.962086066207, 6371.04434334835, 6511.674416279262, 6522.771702990372, 6543.280239173592, 6619.172603424572, 6353.68231588428, 6362.172917520693, 6382.32985536512, 6394.4884409246215, 6422.807315780534], "value": 5001.891574834064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.461875565283, 892.9017808041116, 913.0869130869131, 925.7407925780775, 927.7958849053208, 17778.466646000623, 18715.62568748624, 18901.810981890176, 18924.90537547312, 21743.891280543616, 19425.708614370797, 20979.685304720442, 21005.26481573145, 21048.89475552624, 21072.367828965154, 1022.4121130350042, 1042.2652030318607, 1043.6347278452556, 1049.6011515624052, 1050.1283934334483, 1052.63157894737, 1054.96307629233, 1065.8454524094002, 1065.9360438373722, 1066.4667666166918, 1049.2235745548317, 1051.1170616681986, 1054.6414219165483, 1055.0504545908705, 1098.0776148035648, 1040.4121671255716, 1048.570086264628, 1049.407084996978, 1050.0969166516788, 1099.2580008494274, 760.3992845651928, 762.0436352377786, 763.0804880119442, 772.6754762999553, 809.4333966223667, 18202.0, 18619.62760744791, 18640.440786776417, 18802.0, 18921.81078189214, 20454.0, 20747.377578672666, 20956.16175352984, 21042.894785525976, 21211.893940530197, 15636.452724154713, 15680.0, 15864.603384915354, 15932.362705491767, 16121.193940302937, 3493.68556829884, 3546.202104526487, 3564.108972756811, 3564.2336897567147, 3575.1955809942815, 114153.0, 118638.40680796541, 119963.4001829994, 120551.39724301323, 121721.78278217193, 15685.294161762748, 16103.677926441405, 16251.756223656655, 16309.0, 16430.507084787474, 29915.551266731018, 29946.850265748533, 30009.099727008226, 30186.54720179199, 30232.395352092833, 8244.752657420288, 8539.316854651614, 8610.698625548075, 8625.741227763177, 8659.437136586102, 4221.598948099926, 4281.636060934793, 4304.332828411601, 4309.461317335333, 4319.200947824663, 5207.71357575337, 5261.342332208474, 5328.333958255218, 5355.598330125256, 5365.892682146336, 915.7115508614766, 937.1237892570468, 944.17856464876, 962.1725316228038, 964.0793042644258, 671.1610486891386, 671.3554987212331, 687.9793606191822, 697.4943166204563, 701.3197198717236, 10557.31377460478, 10979.121670266519, 11187.496562654538, 12069.0, 12105.33420661872, 635.5646382228189, 649.9187601549806, 663.4393937123124, 666.9266380698119, 684.0867441964933, 5354.705491197944, 5407.621466497308, 5533.750981205855, 5554.861128471821, 5985.34161242263, 95029.0, 96830.0316996821, 99277.0, 101888.0, 103373.0, 84861.57569212238, 88571.55714221517, 90024.0, 90304.0, 93673.0, 74161.25838741651, 77720.61139694379, 78263.0, 82263.5886820562, 83355.58322208471, 11102.167337449562, 11251.15616328795, 11386.0, 11711.707207319545, 12007.579734709243, 34415.483767743004, 36427.45358819673, 36655.0, 36778.26443471062, 37027.0, 43441.91352925062, 44965.550344496136, 45759.0, 46820.0, 47047.76476117734, 17735.46793596194, 18153.81846181521, 18421.723674145167, 18554.81445185531, 18650.253989840254, 20440.693389599466, 20448.897755511127, 20514.282000129922, 20638.0, 20726.896365518678, 18317.816821832144, 18713.251469941595, 18776.342828000954, 19068.713969290195, 19133.904330478257, 18631.81368186355, 18774.6245075095, 19348.0, 19422.0, 19664.41006769799, 18656.0, 18912.52718682044, 18944.431667050012, 19025.143868525673, 19096.522586935436, 12818.483622264333, 12971.5459958901, 13441.395137219044, 13522.323883805968, 13972.720545589234, 12890.0, 12953.740925181255, 13796.103253288504, 13874.791878122038, 14335.856641433453], "value": 8889.984844308909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 102.0, 115.0, 116.0, 108.0, 113.0, 100.0, 113.0, 113.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 140.0, 174.0, 118.0, 156.0, 150.0, 118.0, 165.0, 121.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 163.0, 169.0, 168.0, 165.0, 166.0, 163.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 177.0, 76.0, 76.0, 74.0, 75.0, 178.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 137.0, 78.0, 78.0, 79.0, 124.0, 86.0, 79.0, 134.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 114.0, 116.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 150.0, 151.0, 150.0, 152.0, 153.0, 149.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 55.0, 55.0, 58.0, 59.0, 54.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 54.0, 55.0, 64.0, 59.0, 55.0, 66.0, 54.0, 54.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 81.0, 81.0, 88.0, 83.0, 81.0, 81.0, 84.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 134.0, 146.0, 134.0, 130.0, 127.0, 128.0, 126.0, 167.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 192.0, 184.0, 190.0, 178.0, 182.0, 197.0, 188.0, 195.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 75.0], "value": 68.7, "unit": "score"}]}]} 03:55:11 INFO - Return code: 0 03:55:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:11 INFO - # TBPL SUCCESS # 03:55:11 INFO - Running post-action listener: _package_coverage_data 03:55:11 INFO - Running post-action listener: _resource_record_post_action 03:55:11 INFO - [mozharness: 2017-07-29 10:55:11.588689Z] Finished run-tests step (success) 03:55:11 INFO - Running post-run listener: _resource_record_post_run 03:55:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431693824; Read time: 8; Write time: 279928 03:55:11 INFO - TinderboxPrint: CPU usage
13.2% 03:55:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:55:11 INFO - TinderboxPrint: I/O write bytes / time
431,693,824 / 279,928 03:55:11 INFO - TinderboxPrint: CPU idle
8,280.0 (86.8%) 03:55:11 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 03:55:11 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107655168; Read time: 0; Write time: 91908 03:55:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:11 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 324038656; Read time: 0; Write time: 188020 03:55:12 INFO - Running post-run listener: _upload_blobber_files 03:55:12 INFO - Blob upload gear active. 03:55:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:55:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:15 INFO - (blobuploader) - INFO - Done attempting. 03:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:16 INFO - (blobuploader) - INFO - Done attempting. 03:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:17 INFO - (blobuploader) - INFO - Done attempting. 03:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:18 INFO - (blobuploader) - INFO - Done attempting. 03:55:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:18 INFO - Return code: 0 03:55:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ee5220263826fa4caf1079e172ac04a00bc0003bbf8c0158d3f9bc37ebd02c0ef47bb7ed19d63dfe61c6b91a4eaea643c41c11c2e687bddd4a2072a1002dd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/854298d7b696e51f7fb37f0d1e71c520b8af96dcf68d34b7c9685c4eb7fda72d90b78c2c6910ba0736d17cf64b7ab97625692443872f281176a4cde4e40ded42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161a994a794bd93dd5aaf25c715fb72989fe34541780d89fca27edf163d221c0dc262dbc784a67c56418abc8a12e212f8ac6731c72bbafe3e9d6226cfcadc542", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371711e8dd104b1d8fb9541f868a9ecaba92ddff0d286c0e745fd3a79175580ed500a73add1338051bad19de2ae3c024e9a7ee9d8d4d73d4d459ac86100819a0"} 03:55:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:18 INFO - Contents: 03:55:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ee5220263826fa4caf1079e172ac04a00bc0003bbf8c0158d3f9bc37ebd02c0ef47bb7ed19d63dfe61c6b91a4eaea643c41c11c2e687bddd4a2072a1002dd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/854298d7b696e51f7fb37f0d1e71c520b8af96dcf68d34b7c9685c4eb7fda72d90b78c2c6910ba0736d17cf64b7ab97625692443872f281176a4cde4e40ded42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161a994a794bd93dd5aaf25c715fb72989fe34541780d89fca27edf163d221c0dc262dbc784a67c56418abc8a12e212f8ac6731c72bbafe3e9d6226cfcadc542", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371711e8dd104b1d8fb9541f868a9ecaba92ddff0d286c0e745fd3a79175580ed500a73add1338051bad19de2ae3c024e9a7ee9d8d4d73d4d459ac86100819a0"} 03:55:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:18 INFO - Copying logs to upload dir... 03:55:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.418659 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-29 03:55:17.977275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:17.982689) ========= 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=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ee5220263826fa4caf1079e172ac04a00bc0003bbf8c0158d3f9bc37ebd02c0ef47bb7ed19d63dfe61c6b91a4eaea643c41c11c2e687bddd4a2072a1002dd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/854298d7b696e51f7fb37f0d1e71c520b8af96dcf68d34b7c9685c4eb7fda72d90b78c2c6910ba0736d17cf64b7ab97625692443872f281176a4cde4e40ded42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161a994a794bd93dd5aaf25c715fb72989fe34541780d89fca27edf163d221c0dc262dbc784a67c56418abc8a12e212f8ac6731c72bbafe3e9d6226cfcadc542", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371711e8dd104b1d8fb9541f868a9ecaba92ddff0d286c0e745fd3a79175580ed500a73add1338051bad19de2ae3c024e9a7ee9d8d4d73d4d459ac86100819a0"} build_url:https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/H5ScIwu-Qs6tguCScglFqQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ee5220263826fa4caf1079e172ac04a00bc0003bbf8c0158d3f9bc37ebd02c0ef47bb7ed19d63dfe61c6b91a4eaea643c41c11c2e687bddd4a2072a1002dd0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/854298d7b696e51f7fb37f0d1e71c520b8af96dcf68d34b7c9685c4eb7fda72d90b78c2c6910ba0736d17cf64b7ab97625692443872f281176a4cde4e40ded42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/161a994a794bd93dd5aaf25c715fb72989fe34541780d89fca27edf163d221c0dc262dbc784a67c56418abc8a12e212f8ac6731c72bbafe3e9d6226cfcadc542", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/371711e8dd104b1d8fb9541f868a9ecaba92ddff0d286c0e745fd3a79175580ed500a73add1338051bad19de2ae3c024e9a7ee9d8d4d73d4d459ac86100819a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:18.011770) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:18.012106) ========= 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=3836458cccd887f2d2de3cf1000001de-1501322325.327368-2112375351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-29 03:55:18.097051) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-29 03:55:18.097826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-29 03:55:18.098493) ========= ========= Total master_lag: 0.04 =========