builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1502072039.79 results: success (0) revision: bb8de16ce00cb57b587a14c210ecc7505f366328 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.788649) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.789109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.789414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.805348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.805610) ========= 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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 19:13:59-- 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% 107M=0s 2017-08-06 19:14:00 (107 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.950765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:13:59.951175) ========= 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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014403 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.000468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.000803) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb8de16ce00cb57b587a14c210ecc7505f366328 --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 bb8de16ce00cb57b587a14c210ecc7505f366328 --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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 19:14:00,187 truncating revision to first 12 chars 2017-08-06 19:14:00,187 Setting DEBUG logging. 2017-08-06 19:14:00,187 attempt 1/10 2017-08-06 19:14:00,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb8de16ce00c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 19:14:00,746 unpacking tar archive at: mozilla-central-bb8de16ce00c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.851735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.865208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.868543) ========= script_repo_revision: bb8de16ce00cb57b587a14c210ecc7505f366328 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.868907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.869166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:14:00.878043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-08-06 19:14:00.878309) ========= /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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:14:01 INFO - MultiFileLogger online at 20170806 19:14:01 in /builds/slave/test 19:14:01 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 19:14:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:14:01 INFO - {'append_to_log': False, 19:14:01 INFO - 'base_work_dir': '/builds/slave/test', 19:14:01 INFO - 'blob_upload_branch': 'Firefox', 19:14:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:14:01 INFO - 'branch': 'Firefox', 19:14:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:14:01 INFO - 'code_coverage': False, 19:14:01 INFO - 'config_files': ('talos/linux_config.py',), 19:14:01 INFO - 'default_actions': ('clobber', 19:14:01 INFO - 'read-buildbot-config', 19:14:01 INFO - 'download-and-extract', 19:14:01 INFO - 'populate-webroot', 19:14:01 INFO - 'create-virtualenv', 19:14:01 INFO - 'install', 19:14:01 INFO - 'setup-mitmproxy', 19:14:01 INFO - 'run-tests'), 19:14:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:14:01 INFO - 'disable_ccov_upload': False, 19:14:01 INFO - 'download_minidump_stackwalk': True, 19:14:01 INFO - 'download_symbols': 'ondemand', 19:14:01 INFO - 'enable_stylo': False, 19:14:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:14:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:14:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:14:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:14:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:14:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:14:01 INFO - 'gecko_profile': False, 19:14:01 INFO - 'gecko_profile_interval': 0, 19:14:01 INFO - 'installer_path': 'installer.exe', 19:14:01 INFO - 'log_level': 'info', 19:14:01 INFO - 'log_name': 'talos', 19:14:01 INFO - 'log_to_console': True, 19:14:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:14:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:14:01 INFO - 'opt_config_files': (), 19:14:01 INFO - 'pip_index': False, 19:14:01 INFO - 'suite': 'dromaeojs-e10s', 19:14:01 INFO - 'system_bits': '32', 19:14:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:14:01 INFO - 'title': 'talos-linux64-ix-038', 19:14:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:14:01 INFO - 'use_talos_json': True, 19:14:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:14:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:14:01 INFO - 'work_dir': 'build'} 19:14:01 INFO - [mozharness: 2017-08-07 02:14:01.174352Z] Running clobber step. 19:14:01 INFO - Running pre-action listener: _resource_record_pre_action 19:14:01 INFO - Running main action method: clobber 19:14:01 INFO - rmtree: /builds/slave/test/build 19:14:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:14:02 INFO - Running post-action listener: _resource_record_post_action 19:14:02 INFO - [mozharness: 2017-08-07 02:14:02.402462Z] Finished clobber step (success) 19:14:02 INFO - [mozharness: 2017-08-07 02:14:02.402565Z] Running read-buildbot-config step. 19:14:02 INFO - Running pre-action listener: _resource_record_pre_action 19:14:02 INFO - Running main action method: read_buildbot_config 19:14:02 INFO - Using buildbot properties: 19:14:02 INFO - { 19:14:02 INFO - "project": "", 19:14:02 INFO - "product": "firefox", 19:14:02 INFO - "who": "ryanvm@gmail.com", 19:14:02 INFO - "installer_path": "public/build/target.tar.bz2", 19:14:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:14:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:14:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:14:02 INFO - "stage_platform": "linux64-stylo", 19:14:02 INFO - "basedir": "/builds/slave/test", 19:14:02 INFO - "buildnumber": 67, 19:14:02 INFO - "platform": "ubuntu64_hw_stylo", 19:14:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:14:02 INFO - "slavebuilddir": "test", 19:14:02 INFO - "taskId": "TyWd-A9fRfeMyZzPxFRPnA", 19:14:02 INFO - "branch": "mozilla-central", 19:14:02 INFO - "script_repo_revision": "production", 19:14:02 INFO - "revision": "bb8de16ce00cb57b587a14c210ecc7505f366328", 19:14:02 INFO - "slavename": "talos-linux64-ix-038", 19:14:02 INFO - "repo_path": "mozilla-central" 19:14:02 INFO - } 19:14:02 INFO - Finding installer, test and symbols from parent task. 19:14:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TyWd-A9fRfeMyZzPxFRPnA'}, attempt #1 19:14:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TyWd-A9fRfeMyZzPxFRPnA'}, attempt #1 19:14:03 INFO - Task dependencies: QgPvyoURQK6UatzOSij_TA 19:14:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA'}, attempt #1 19:14:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:14:11 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json 19:14:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip 19:14:11 INFO - Running post-action listener: _resource_record_post_action 19:14:11 INFO - [mozharness: 2017-08-07 02:14:11.300684Z] Finished read-buildbot-config step (success) 19:14:11 INFO - [mozharness: 2017-08-07 02:14:11.300910Z] Running download-and-extract step. 19:14:11 INFO - Running pre-action listener: _resource_record_pre_action 19:14:11 INFO - Running main action method: download_and_extract 19:14:11 INFO - mkdir: /builds/slave/test/build/tests 19:14: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')]} 19:14:11 INFO - trying https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json 19:14:11 INFO - Downloading https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:14:19 INFO - Downloaded 989 bytes. 19:14:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:14:19 INFO - Using the following test package requirements: 19:14:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:14:19 INFO - u'common': [u'target.common.tests.zip'], 19:14:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:14:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:14:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:14:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:14:19 INFO - u'mozbase': [u'target.common.tests.zip'], 19:14:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:14:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:14:19 INFO - u'web-platform': [u'target.common.tests.zip', 19:14:19 INFO - u'target.web-platform.tests.tar.gz'], 19:14:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:14:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip 19:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip into memory 19:14:27 INFO - Content-Length response header: 54284786 19:14:27 INFO - Bytes received: 54284786 19:14:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:14:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip 19:14:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:14:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip into memory 19:14:40 INFO - Content-Length response header: 54284786 19:14:40 INFO - Bytes received: 54284786 19:14:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip 19:14:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:14:51 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip into memory 19:14:52 INFO - Content-Length response header: 14496008 19:14:52 INFO - Bytes received: 14496008 19:14: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')]} 19:14:53 INFO - trying https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:14:53 INFO - Downloading https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:14:54 INFO - Downloaded 61918259 bytes. 19:14:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:14:54 INFO - mkdir: /builds/slave/test/properties 19:14:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:14:54 INFO - Writing to file /builds/slave/test/properties/build_url 19:14:54 INFO - Contents: 19:14:54 INFO - build_url:https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:14:54 INFO - Running post-action listener: _resource_record_post_action 19:14:54 INFO - Running post-action listener: set_extra_try_arguments 19:14:54 INFO - [mozharness: 2017-08-07 02:14:54.275698Z] Finished download-and-extract step (success) 19:14:54 INFO - [mozharness: 2017-08-07 02:14:54.275796Z] Running populate-webroot step. 19:14:54 INFO - Running pre-action listener: _resource_record_pre_action 19:14:54 INFO - Running main action method: populate_webroot 19:14:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:14:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:14:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:14:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:14:54 INFO - 'tests': ['damp', 'tps']}, 19:14:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:14:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:14:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:14:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:14:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:14:54 INFO - 'ts_paint', 19:14:54 INFO - 'tpaint', 19:14:54 INFO - 'sessionrestore', 19:14:54 INFO - 'sessionrestore_many_windows', 19:14:54 INFO - 'sessionrestore_no_auto_restore', 19:14:54 INFO - 'tabpaint']}, 19:14:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:14:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:14:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:14:54 INFO - 'tsvgr_opacity', 19:14:54 INFO - 'tart', 19:14:54 INFO - 'tscrollx', 19:14:54 INFO - 'tsvg_static']}, 19:14:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:14:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:14:54 INFO - 'talos_options': ['--mitmproxy', 19:14:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:14:54 INFO - '--firstNonBlankPaint'], 19:14:54 INFO - 'tests': ['tp6_google', 19:14:54 INFO - 'tp6_youtube', 19:14:54 INFO - 'tp6_amazon', 19:14:54 INFO - 'tp6_facebook']}, 19:14:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:14:54 INFO - 'talos_options': ['--stylo', 19:14:54 INFO - '--mitmproxy', 19:14:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:14:54 INFO - '--firstNonBlankPaint'], 19:14:54 INFO - 'tests': ['tp6_google', 19:14:54 INFO - 'tp6_youtube', 19:14:54 INFO - 'tp6_amazon', 19:14:54 INFO - 'tp6_facebook']}, 19:14:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:14:54 INFO - 'talos_options': ['--stylo', 19:14:54 INFO - '--stylo-threads=1', 19:14:54 INFO - '--mitmproxy', 19:14:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:14:54 INFO - '--firstNonBlankPaint'], 19:14:54 INFO - 'tests': ['tp6_google', 19:14:54 INFO - 'tp6_youtube', 19:14:54 INFO - 'tp6_amazon', 19:14:54 INFO - 'tp6_facebook']}, 19:14:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:14:54 INFO - 'talos_options': ['--xperf_path', 19:14:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:54 INFO - 'tests': ['tp5n']}}} 19:14:54 INFO - Running post-action listener: _resource_record_post_action 19:14:54 INFO - [mozharness: 2017-08-07 02:14:54.284305Z] Finished populate-webroot step (success) 19:14:54 INFO - [mozharness: 2017-08-07 02:14:54.284396Z] Running create-virtualenv step. 19:14:54 INFO - Running pre-action listener: _resource_record_pre_action 19:14:54 INFO - Running main action method: create_virtualenv 19:14:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:14: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 19:14:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:14:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:14:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:14:54 INFO - Using real prefix '/usr' 19:14:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:14:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:14:56 INFO - Installing pip.................done. 19:14:56 INFO - Return code: 0 19:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:14:57 INFO - Reading from file tmpfile_stdout 19:14:57 INFO - Output received: 19:14: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) 19:14:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14: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')]} 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:14: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 19:14: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 19:14:57 INFO - Using env: {'DISPLAY': ':0', 19:14:57 INFO - 'HOME': '/home/cltbld', 19:14:57 INFO - 'LANG': 'en_US.UTF-8', 19:14:57 INFO - 'LANGUAGE': 'en_US:en', 19:14:57 INFO - 'LOGNAME': 'cltbld', 19:14:57 INFO - 'MAIL': '/var/mail/cltbld', 19:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:57 INFO - 'MOZ_NO_REMOTE': '1', 19:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:57 INFO - 'NO_EM_RESTART': '1', 19:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:57 INFO - 'PWD': '/builds/slave/test', 19:14:57 INFO - 'SHELL': '/bin/bash', 19:14:57 INFO - 'SHLVL': '1', 19:14:57 INFO - 'TERM': 'linux', 19:14:57 INFO - 'TMOUT': '86400', 19:14:57 INFO - 'USER': 'cltbld', 19:14:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:57 INFO - '_': '/tools/buildbot/bin/python'} 19:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14: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 19:14:57 INFO - Cleaning up... 19:14:57 INFO - Return code: 0 19:14:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14: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')]} 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:14: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 19:14: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 19:14:57 INFO - Using env: {'DISPLAY': ':0', 19:14:57 INFO - 'HOME': '/home/cltbld', 19:14:57 INFO - 'LANG': 'en_US.UTF-8', 19:14:57 INFO - 'LANGUAGE': 'en_US:en', 19:14:57 INFO - 'LOGNAME': 'cltbld', 19:14:57 INFO - 'MAIL': '/var/mail/cltbld', 19:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:57 INFO - 'MOZ_NO_REMOTE': '1', 19:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:57 INFO - 'NO_EM_RESTART': '1', 19:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:57 INFO - 'PWD': '/builds/slave/test', 19:14:57 INFO - 'SHELL': '/bin/bash', 19:14:57 INFO - 'SHLVL': '1', 19:14:57 INFO - 'TERM': 'linux', 19:14:57 INFO - 'TMOUT': '86400', 19:14:57 INFO - 'USER': 'cltbld', 19:14:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:57 INFO - '_': '/tools/buildbot/bin/python'} 19:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:57 INFO - Downloading/unpacking psutil>=3.1.1 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:58 INFO - Installing collected packages: psutil 19:14:58 INFO - Running setup.py install for psutil 19:14:58 INFO - building 'psutil._psutil_linux' extension 19:14:58 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 19:14:58 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 19:14:58 INFO - building 'psutil._psutil_posix' extension 19:14:58 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 19:14: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 19:14:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:59 INFO - Successfully installed psutil 19:14:59 INFO - Cleaning up... 19:14:59 INFO - Return code: 0 19:14:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14: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')]} 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:14: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 19:14: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 19:14:59 INFO - Using env: {'DISPLAY': ':0', 19:14:59 INFO - 'HOME': '/home/cltbld', 19:14:59 INFO - 'LANG': 'en_US.UTF-8', 19:14:59 INFO - 'LANGUAGE': 'en_US:en', 19:14:59 INFO - 'LOGNAME': 'cltbld', 19:14:59 INFO - 'MAIL': '/var/mail/cltbld', 19:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:59 INFO - 'MOZ_NO_REMOTE': '1', 19:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:14:59 INFO - 'NO_EM_RESTART': '1', 19:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:59 INFO - 'PWD': '/builds/slave/test', 19:14:59 INFO - 'SHELL': '/bin/bash', 19:14:59 INFO - 'SHLVL': '1', 19:14:59 INFO - 'TERM': 'linux', 19:14:59 INFO - 'TMOUT': '86400', 19:14:59 INFO - 'USER': 'cltbld', 19:14:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:59 INFO - '_': '/tools/buildbot/bin/python'} 19:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:15:00 INFO - Installing collected packages: mozsystemmonitor 19:15:00 INFO - Running setup.py install for mozsystemmonitor 19:15:00 INFO - Successfully installed mozsystemmonitor 19:15:00 INFO - Cleaning up... 19:15:00 INFO - Return code: 0 19:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:15:00 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')]} 19:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:00 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')]} 19:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:00 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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15:00 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 19:15:00 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 19:15:00 INFO - Using env: {'DISPLAY': ':0', 19:15:00 INFO - 'HOME': '/home/cltbld', 19:15:00 INFO - 'LANG': 'en_US.UTF-8', 19:15:00 INFO - 'LANGUAGE': 'en_US:en', 19:15:00 INFO - 'LOGNAME': 'cltbld', 19:15:00 INFO - 'MAIL': '/var/mail/cltbld', 19:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:00 INFO - 'MOZ_NO_REMOTE': '1', 19:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:00 INFO - 'NO_EM_RESTART': '1', 19:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:00 INFO - 'PWD': '/builds/slave/test', 19:15:00 INFO - 'SHELL': '/bin/bash', 19:15:00 INFO - 'SHLVL': '1', 19:15:00 INFO - 'TERM': 'linux', 19:15:00 INFO - 'TMOUT': '86400', 19:15:00 INFO - 'USER': 'cltbld', 19:15:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:00 INFO - '_': '/tools/buildbot/bin/python'} 19:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 19:15: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 19:15: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 19:15: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 19:15: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 19:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:15:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:15: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 19:15: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 19:15: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 19:15: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 19:15:02 INFO - Downloading functools32-3.2.3-2.tar.gz 19:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:15:02 INFO - warning: no files found matching '*.txt' 19:15:02 INFO - no previously-included directories found matching 'build' 19:15:02 INFO - no previously-included directories found matching 'dist' 19:15:02 INFO - no previously-included directories found matching '.git*' 19:15:02 INFO - Installing collected packages: jsonschema, functools32 19:15:02 INFO - Running setup.py install for functools32 19:15:02 INFO - warning: no files found matching '*.txt' 19:15:02 INFO - no previously-included directories found matching 'build' 19:15:02 INFO - no previously-included directories found matching 'dist' 19:15:02 INFO - no previously-included directories found matching '.git*' 19:15:02 INFO - Successfully installed jsonschema functools32 19:15:02 INFO - Cleaning up... 19:15:02 INFO - Return code: 0 19:15:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:15:02 INFO - Using env: {'DISPLAY': ':0', 19:15:02 INFO - 'HOME': '/home/cltbld', 19:15:02 INFO - 'LANG': 'en_US.UTF-8', 19:15:02 INFO - 'LANGUAGE': 'en_US:en', 19:15:02 INFO - 'LOGNAME': 'cltbld', 19:15:02 INFO - 'MAIL': '/var/mail/cltbld', 19:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:02 INFO - 'MOZ_NO_REMOTE': '1', 19:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:02 INFO - 'NO_EM_RESTART': '1', 19:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:02 INFO - 'PWD': '/builds/slave/test', 19:15:02 INFO - 'SHELL': '/bin/bash', 19:15:02 INFO - 'SHLVL': '1', 19:15:02 INFO - 'TERM': 'linux', 19:15:02 INFO - 'TMOUT': '86400', 19:15:02 INFO - 'USER': 'cltbld', 19:15:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:02 INFO - '_': '/tools/buildbot/bin/python'} 19:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:15:02 INFO - Cleaning up... 19:15:02 INFO - Return code: 0 19:15:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:15:02 INFO - Using env: {'DISPLAY': ':0', 19:15:02 INFO - 'HOME': '/home/cltbld', 19:15:02 INFO - 'LANG': 'en_US.UTF-8', 19:15:02 INFO - 'LANGUAGE': 'en_US:en', 19:15:02 INFO - 'LOGNAME': 'cltbld', 19:15:02 INFO - 'MAIL': '/var/mail/cltbld', 19:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:02 INFO - 'MOZ_NO_REMOTE': '1', 19:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:02 INFO - 'NO_EM_RESTART': '1', 19:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:02 INFO - 'PWD': '/builds/slave/test', 19:15:02 INFO - 'SHELL': '/bin/bash', 19:15:02 INFO - 'SHLVL': '1', 19:15:02 INFO - 'TERM': 'linux', 19:15:02 INFO - 'TMOUT': '86400', 19:15:02 INFO - 'USER': 'cltbld', 19:15:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:02 INFO - '_': '/tools/buildbot/bin/python'} 19:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:15: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 19:15: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 19:15: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 19:15: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 19:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:15: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 19:15: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 19:15: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 19:15: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 19:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:15:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:15: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 19:15: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 19:15: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 19:15: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 19:15:04 INFO - Downloading docopt-0.6.1.tar.gz 19:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:15:04 INFO - Running setup.py install for blobuploader 19:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:15:04 INFO - Running setup.py install for requests 19:15:04 INFO - Running setup.py install for docopt 19:15:05 INFO - Successfully installed blobuploader requests docopt 19:15:05 INFO - Cleaning up... 19:15:05 INFO - Return code: 0 19:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15: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')]} 19:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15: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 19:15: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 19:15:05 INFO - Using env: {'DISPLAY': ':0', 19:15:05 INFO - 'HOME': '/home/cltbld', 19:15:05 INFO - 'LANG': 'en_US.UTF-8', 19:15:05 INFO - 'LANGUAGE': 'en_US:en', 19:15:05 INFO - 'LOGNAME': 'cltbld', 19:15:05 INFO - 'MAIL': '/var/mail/cltbld', 19:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:05 INFO - 'MOZ_NO_REMOTE': '1', 19:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:05 INFO - 'NO_EM_RESTART': '1', 19:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:05 INFO - 'PWD': '/builds/slave/test', 19:15:05 INFO - 'SHELL': '/bin/bash', 19:15:05 INFO - 'SHLVL': '1', 19:15:05 INFO - 'TERM': 'linux', 19:15:05 INFO - 'TMOUT': '86400', 19:15:05 INFO - 'USER': 'cltbld', 19:15:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:05 INFO - '_': '/tools/buildbot/bin/python'} 19:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:05 INFO - Running setup.py (path:/tmp/pip-eygUo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:05 INFO - Running setup.py (path:/tmp/pip-IB7KX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:05 INFO - Running setup.py (path:/tmp/pip-EMXrL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:05 INFO - Running setup.py (path:/tmp/pip-UWUQXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:05 INFO - Running setup.py (path:/tmp/pip-jqSMIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:05 INFO - Running setup.py (path:/tmp/pip-puz6pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:05 INFO - Running setup.py (path:/tmp/pip-76_ONy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:05 INFO - Running setup.py (path:/tmp/pip-R18b_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:05 INFO - Running setup.py (path:/tmp/pip-3nxmP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:05 INFO - Running setup.py (path:/tmp/pip-zOQy74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:06 INFO - Running setup.py (path:/tmp/pip-dEEOB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:06 INFO - Running setup.py (path:/tmp/pip-nKMCUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:06 INFO - Running setup.py (path:/tmp/pip-W_OHW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:06 INFO - Running setup.py (path:/tmp/pip-wFGpmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:06 INFO - Running setup.py (path:/tmp/pip-4pMTCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:06 INFO - Running setup.py (path:/tmp/pip-46G_JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:06 INFO - Running setup.py (path:/tmp/pip-rdg3RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:15:06 INFO - Running setup.py install for manifestparser 19:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:15:06 INFO - Running setup.py install for mozcrash 19:15:06 INFO - Running setup.py install for mozdebug 19:15:06 INFO - Running setup.py install for mozdevice 19:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:15:06 INFO - Running setup.py install for mozfile 19:15:07 INFO - Running setup.py install for mozhttpd 19:15:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozinfo 19:15:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozInstall 19:15:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozleak 19:15:07 INFO - Running setup.py install for mozlog 19:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for moznetwork 19:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozprocess 19:15:07 INFO - Running setup.py install for mozprofile 19:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozrunner 19:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:15:07 INFO - Running setup.py install for mozscreenshot 19:15:08 INFO - Running setup.py install for moztest 19:15:08 INFO - Running setup.py install for mozversion 19:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:15:08 INFO - Cleaning up... 19:15:08 INFO - Return code: 0 19:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15: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')]} 19:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15: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 19:15: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 19:15:08 INFO - Using env: {'DISPLAY': ':0', 19:15:08 INFO - 'HOME': '/home/cltbld', 19:15:08 INFO - 'LANG': 'en_US.UTF-8', 19:15:08 INFO - 'LANGUAGE': 'en_US:en', 19:15:08 INFO - 'LOGNAME': 'cltbld', 19:15:08 INFO - 'MAIL': '/var/mail/cltbld', 19:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:08 INFO - 'MOZ_NO_REMOTE': '1', 19:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:08 INFO - 'NO_EM_RESTART': '1', 19:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:08 INFO - 'PWD': '/builds/slave/test', 19:15:08 INFO - 'SHELL': '/bin/bash', 19:15:08 INFO - 'SHLVL': '1', 19:15:08 INFO - 'TERM': 'linux', 19:15:08 INFO - 'TMOUT': '86400', 19:15:08 INFO - 'USER': 'cltbld', 19:15:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:08 INFO - '_': '/tools/buildbot/bin/python'} 19:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:08 INFO - Running setup.py (path:/tmp/pip-NJjnnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:08 INFO - Running setup.py (path:/tmp/pip-5sA08Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:08 INFO - Running setup.py (path:/tmp/pip-XEuW3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:08 INFO - Running setup.py (path:/tmp/pip-fefxTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:08 INFO - Running setup.py (path:/tmp/pip-i13mM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:08 INFO - Running setup.py (path:/tmp/pip-Sx9rFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:08 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)) 19:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:08 INFO - Running setup.py (path:/tmp/pip-lAsS8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:09 INFO - Running setup.py (path:/tmp/pip-1XtvwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:09 INFO - Running setup.py (path:/tmp/pip-XqMLrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:09 INFO - Running setup.py (path:/tmp/pip-4dLAn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:09 INFO - Running setup.py (path:/tmp/pip-HFQZ18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:09 INFO - Running setup.py (path:/tmp/pip-jt1ASO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15: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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:09 INFO - Running setup.py (path:/tmp/pip-5fX0q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:09 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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:09 INFO - Running setup.py (path:/tmp/pip-JJYYpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:09 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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:09 INFO - Running setup.py (path:/tmp/pip-BCtt9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:09 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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:09 INFO - Running setup.py (path:/tmp/pip-6BlqQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:09 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)) 19:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:09 INFO - Running setup.py (path:/tmp/pip-9jfJo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:09 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)) 19:15:09 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)) 19:15:09 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)) 19:15:09 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)) 19:15:09 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)) 19:15:09 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)) 19:15:09 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)) 19:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:15:09 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 19:15:09 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 19:15:09 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 19:15:09 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 19:15:10 INFO - Downloading blessings-1.6.tar.gz 19:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:15:10 INFO - Installing collected packages: blessings 19:15:10 INFO - Running setup.py install for blessings 19:15:11 INFO - Successfully installed blessings 19:15:11 INFO - Cleaning up... 19:15:11 INFO - Return code: 0 19:15:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:11 INFO - Reading from file tmpfile_stdout 19:15:11 INFO - Current package versions: 19:15:11 INFO - argparse == 1.2.1 19:15:11 INFO - blessings == 1.6 19:15:11 INFO - blobuploader == 1.2.4 19:15:11 INFO - docopt == 0.6.1 19:15:11 INFO - functools32 == 3.2.3-2 19:15:11 INFO - jsonschema == 2.5.1 19:15:11 INFO - manifestparser == 1.1 19:15:11 INFO - mozInstall == 1.13 19:15:11 INFO - mozcrash == 1.0 19:15:11 INFO - mozdebug == 0.1 19:15:11 INFO - mozdevice == 0.51 19:15:11 INFO - mozfile == 1.2 19:15:11 INFO - mozhttpd == 0.7 19:15:11 INFO - mozinfo == 0.10 19:15:11 INFO - mozleak == 0.1 19:15:11 INFO - mozlog == 3.5 19:15:11 INFO - moznetwork == 0.27 19:15:11 INFO - mozprocess == 0.25 19:15:11 INFO - mozprofile == 0.28 19:15:11 INFO - mozrunner == 6.13 19:15:11 INFO - mozscreenshot == 0.1 19:15:11 INFO - mozsystemmonitor == 0.3 19:15:11 INFO - moztest == 0.8 19:15:11 INFO - mozversion == 1.4 19:15:11 INFO - psutil == 3.1.1 19:15:11 INFO - requests == 1.2.3 19:15:11 INFO - wsgiref == 0.1.2 19:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15: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')]} 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15: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')]} 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15: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 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15: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 19:15: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 19:15:11 INFO - Using env: {'DISPLAY': ':0', 19:15:11 INFO - 'HOME': '/home/cltbld', 19:15:11 INFO - 'LANG': 'en_US.UTF-8', 19:15:11 INFO - 'LANGUAGE': 'en_US:en', 19:15:11 INFO - 'LOGNAME': 'cltbld', 19:15:11 INFO - 'MAIL': '/var/mail/cltbld', 19:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:11 INFO - 'MOZ_NO_REMOTE': '1', 19:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:11 INFO - 'NO_EM_RESTART': '1', 19:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:11 INFO - 'PWD': '/builds/slave/test', 19:15:11 INFO - 'SHELL': '/bin/bash', 19:15:11 INFO - 'SHLVL': '1', 19:15:11 INFO - 'TERM': 'linux', 19:15:11 INFO - 'TMOUT': '86400', 19:15:11 INFO - 'USER': 'cltbld', 19:15:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:11 INFO - '_': '/tools/buildbot/bin/python'} 19:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:15:12 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)) 19:15:12 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)) 19:15:12 INFO - Installing collected packages: simplejson 19:15:12 INFO - Running setup.py install for simplejson 19:15:12 INFO - building 'simplejson._speedups' extension 19:15:12 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 19:15:13 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 19:15:13 INFO - Successfully installed simplejson 19:15:13 INFO - Cleaning up... 19:15:13 INFO - Return code: 0 19:15:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, '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': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', '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 19:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:15:13 INFO - Using env: {'DISPLAY': ':0', 19:15:13 INFO - 'HOME': '/home/cltbld', 19:15:13 INFO - 'LANG': 'en_US.UTF-8', 19:15:13 INFO - 'LANGUAGE': 'en_US:en', 19:15:13 INFO - 'LOGNAME': 'cltbld', 19:15:13 INFO - 'MAIL': '/var/mail/cltbld', 19:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:13 INFO - 'MOZ_NO_REMOTE': '1', 19:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:13 INFO - 'NO_EM_RESTART': '1', 19:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:13 INFO - 'PWD': '/builds/slave/test', 19:15:13 INFO - 'SHELL': '/bin/bash', 19:15:13 INFO - 'SHLVL': '1', 19:15:13 INFO - 'TERM': 'linux', 19:15:13 INFO - 'TMOUT': '86400', 19:15:13 INFO - 'USER': 'cltbld', 19:15:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:13 INFO - '_': '/tools/buildbot/bin/python'} 19:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:15:13 INFO - Cleaning up... 19:15:13 INFO - Return code: 0 19:15:13 INFO - Running post-action listener: _resource_record_post_action 19:15:13 INFO - Running post-action listener: _start_resource_monitoring 19:15:14 INFO - Starting resource monitoring. 19:15:14 INFO - [mozharness: 2017-08-07 02:15:14.010166Z] Finished create-virtualenv step (success) 19:15:14 INFO - [mozharness: 2017-08-07 02:15:14.010680Z] Running install step. 19:15:14 INFO - Running pre-action listener: _resource_record_pre_action 19:15:14 INFO - Running main action method: install 19:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:14 INFO - Reading from file tmpfile_stdout 19:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:15:14 INFO - Reading from file tmpfile_stdout 19:15:14 INFO - Output received: 19:15:14 INFO - Usage: mozinstall [options] installer 19:15:14 INFO - Options: 19:15:14 INFO - -h, --help show this help message and exit 19:15:14 INFO - -d DEST, --destination=DEST 19:15:14 INFO - Directory to install application into. [default: 19:15:14 INFO - "/builds/slave/test"] 19:15:14 INFO - --app=APP Application being installed. [default: firefox] 19:15:14 INFO - mkdir: /builds/slave/test/build/application 19:15:14 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'] 19:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:15:32 INFO - Reading from file tmpfile_stdout 19:15:32 INFO - Output received: 19:15:32 INFO - /builds/slave/test/build/application/firefox/firefox 19:15:32 INFO - Running post-action listener: _resource_record_post_action 19:15:32 INFO - [mozharness: 2017-08-07 02:15:32.292624Z] Finished install step (success) 19:15:32 INFO - [mozharness: 2017-08-07 02:15:32.292907Z] Running setup-mitmproxy step. 19:15:32 INFO - Running pre-action listener: _resource_record_pre_action 19:15:32 INFO - Running main action method: setup_mitmproxy 19:15:32 INFO - Skipping: mitmproxy is not required 19:15:32 INFO - Running post-action listener: _resource_record_post_action 19:15:32 INFO - [mozharness: 2017-08-07 02:15:32.294066Z] Finished setup-mitmproxy step (success) 19:15:32 INFO - [mozharness: 2017-08-07 02:15:32.294287Z] Running run-tests step. 19:15:32 INFO - Running pre-action listener: _resource_record_pre_action 19:15:32 INFO - Running pre-action listener: _set_gcov_prefix 19:15:32 INFO - Running main action method: run_tests 19:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:15:32 INFO - Python 2.7.3 19:15:32 INFO - Return code: 0 19:15:32 INFO - grabbing minidump binary from tooltool 19:15:32 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')]} 19:15:32 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 0x1ea2eb0>, '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 0x1ea3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:15:32 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 19:15:32 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 19:15:32 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 19:15:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:15:32 INFO - Return code: 0 19:15:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:15:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:15:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:15:32 INFO - ENV: RUST_BACKTRACE is now 1 19:15:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:15:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:15:32 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:15:32 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 19:15:32 INFO - Using env: {'DISPLAY': ':0', 19:15:32 INFO - 'HOME': '/home/cltbld', 19:15:32 INFO - 'LANG': 'en_US.UTF-8', 19:15:32 INFO - 'LANGUAGE': 'en_US:en', 19:15:32 INFO - 'LOGNAME': 'cltbld', 19:15:32 INFO - 'MAIL': '/var/mail/cltbld', 19:15:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:32 INFO - 'MOZ_NO_REMOTE': '1', 19:15:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:32 INFO - 'NO_EM_RESTART': '1', 19:15:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:32 INFO - 'PWD': '/builds/slave/test', 19:15:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:32 INFO - 'RUST_BACKTRACE': '1', 19:15:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:15:32 INFO - 'SHELL': '/bin/bash', 19:15:32 INFO - 'SHLVL': '1', 19:15:32 INFO - 'STYLO_FORCE_ENABLED': '1', 19:15:32 INFO - 'TERM': 'linux', 19:15:32 INFO - 'TMOUT': '86400', 19:15:32 INFO - 'USER': 'cltbld', 19:15:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870', 19:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:32 INFO - '_': '/tools/buildbot/bin/python'} 19:15:32 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:15:32 INFO - mozversion application_buildid: 20170807011813 19:15:32 INFO - mozversion application_changeset: bb8de16ce00cb57b587a14c210ecc7505f366328 19:15:32 INFO - mozversion application_display_name: Nightly 19:15:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:15:32 INFO - mozversion application_name: Firefox 19:15:32 INFO - mozversion application_remotingname: firefox 19:15:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:15:32 INFO - mozversion application_vendor: Mozilla 19:15:32 INFO - mozversion application_version: 57.0a1 19:15:32 INFO - mozversion platform_buildid: 20170807011813 19:15:32 INFO - mozversion platform_changeset: bb8de16ce00cb57b587a14c210ecc7505f366328 19:15:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:15:32 INFO - mozversion platform_version: 57.0a1 19:15:32 INFO - using testdate: 1502072132 19:15:32 INFO - actual date: 1502072132 19:15:32 INFO - starting webserver on 'localhost:49435' 19:15:32 INFO - SUITE-START | Running 2 tests 19:15:32 INFO - TEST-START | dromaeo_css 19:15:32 INFO - Initialising browser for dromaeo_css test... 19:15:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49435/getInfo.html -profile /tmp/tmpt7bXQs/profile 19:15:32 INFO - TEST-INFO | started process 27980 (/builds/slave/test/build/application/firefox/firefox http://localhost:49435/getInfo.html) 19:15:39 INFO - TEST-INFO | 27980: exit 0 19:15:40 INFO - Browser initialized. 19:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 19:15:40 INFO - TEST-INFO | started process 28207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7bXQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:41 INFO - PID 28207 | 19:15:41 INFO - PID 28207 | (/builds/slave/test/build/application/firefox/firefox:28261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:15:41 INFO - PID 28207 | 19:15:51 INFO - PID 28207 | RSS: Main: 173555712 19:15:51 INFO - PID 28207 | 19:15:51 INFO - PID 28207 | serialization: Helvetica 19:15:51 INFO - PID 28207 | serialization: Arial 19:18:51 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49435/tests/dromaeo/cssquery-ext.html) 19:18:52 INFO - PID 28207 | RSS: Main: 175493120 19:18:52 INFO - PID 28207 | 19:18:52 INFO - PID 28207 | serialization: Helvetica 19:18:52 INFO - PID 28207 | serialization: Arial 19:21:54 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-ext.html (next: http://localhost:49435/tests/dromaeo/cssquery-jquery.html) 19:21:55 INFO - PID 28207 | RSS: Main: 172552192 19:21:55 INFO - PID 28207 | 19:21:55 INFO - PID 28207 | serialization: Helvetica 19:21:55 INFO - PID 28207 | serialization: Arial 19:24:57 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49435/tests/dromaeo/cssquery-mootools.html) 19:24:57 INFO - PID 28207 | RSS: Main: 175058944 19:24:57 INFO - PID 28207 | 19:24:57 INFO - PID 28207 | serialization: Helvetica 19:24:57 INFO - PID 28207 | serialization: Arial 19:27:59 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49435/tests/dromaeo/cssquery-prototype.html) 19:28:00 INFO - PID 28207 | RSS: Main: 173617152 19:28:00 INFO - PID 28207 | 19:28:00 INFO - PID 28207 | serialization: Helvetica 19:28:00 INFO - PID 28207 | serialization: Arial 19:31:04 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49435/tests/dromaeo/cssquery-yui.html) 19:31:04 INFO - PID 28207 | RSS: Main: 176410624 19:31:04 INFO - PID 28207 | 19:31:04 INFO - PID 28207 | serialization: Helvetica 19:31:04 INFO - PID 28207 | serialization: Arial 19:34:06 INFO - PID 28207 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-yui.html (next: http://localhost:49435/tests/dromaeo/cssquery-dojo.html) 19:34:06 INFO - PID 28207 | RSS: Main: 177778688 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | __start_tp_report 19:34:06 INFO - PID 28207 | _x_x_mozilla_page_load 19:34:06 INFO - PID 28207 | _x_x_mozilla_page_load_details 19:34:06 INFO - PID 28207 | |i|pagename|runs| 19:34:06 INFO - PID 28207 | |0;dojo.html;3139.7331226845718;3151.2752067024585;3181.85681644326;3185.2673885006434;3221.4201443740117;6223.284322302937;6252.874942501147;6299.086632438294;6323.241211054668;6344.206974128234;6011.248593925759;6162.322144564095;6177.629342239457;6186.2885768136675;6191.535634827384;5650.943490565093;5664.065429204176;5685.914711279334;5697.544196464273;5734.942650573504;5661.065924122536;5709.514691251228;5721;5767.1349297605275;5789.305283366002;5793.913091303634;5794.0729483282685;5797.623154494944;5801.506871915893;5830.737616807232;5611.0741727614895;5667.603267771257;5760.510356619692;5770.422957704238;5784.68184249866;5475.0966090595;5567.081431563787;5633.971830140864;5656.943430565724;5659.490645841894;6085.847853803646;6141.692915354214;6144.78493252734;6213.720382582795;6233.844153896143;6534.117894084333;6624.768133115318;6715.395614394728;6719.496037797136;6749.5612785168805;6699.899501507482;6730.427913627347;6755.290694477058;6808.353206445379;6827.863442731117;6257.718402671845;6284.5600807943465;6285.465735412496;6290.433860952537;6295.150154729053;6904.896426553606;6975.476839237078;6982.057422248033;6991.370776630128;6997.160340759141;6559.409653131241;6571.605703657796;6585.6707164641575;6663.4669226461765;6681.599104053772;6460.580062295936;6584.176977877765;6625.933740662628;6634.170728658918;6693.330666933268;6538.771143009972;6541.215054193527;6588.4729221662155;6593.604383736991;6654.900176497356;6656.633885136364;6658.234303055114;6663.300353462913;6678.632675202911;6681.5656982296;5367.490088441592;5368.973155134199;5388.191771234267;5399.460053994648;5406.78372865081;4611.077784443125;4681.812727490862;4698.88252793676;4713.34013238147;4738.763061846894;5650.237217975603;5754.913676294859;5829.47534721877;5841.4450627190345;5853.824385268449;6697.665116744241;6714.462842972551;6716.059751634775;6717.899231511531;6744.089547911068;5727.169560413717;5738.139279108167;5772.3938986406665;5798.9420105799245;5801.9129713054335;5780.797672081541;5890.911636325459;5893.646381217055;5898.321693005273;5956.285245770535;6421.068945002949;6447.967760161357;6477.805665830033;6486.481081513562;6490.545661803629;6237.12680224778;6741.764038258638;6755.1556055493065;6798.082258894986;6838.521303508706;6446.29090800021;6449.742010319723;6459.192600924885;6536.509761767791;6541.70562324706;6464.353564643498;6544.869102618016;6556.573822701509;6588.04473351371;6660.866782664417;6692.765753198614;6754.932450675627;6757.729690812313;6762.797116086525;6768.08630834831;6454.580452270588;6504.772332968323;6514.869702606016;6535.183102112236;6540.771073012422;6522.641254731036;6528.510361722795;6544.8363790905605;6545.574537655038;6546.214454265519;6415.807525774234;6422.133012043314;6434.742610295536;6454.67726613658;6455.741770329134;6533.346665333429;6557.344265573404;6570.8028759137305;6628.900566491603;6677.131972843499;6292.087647291209;6319.8104056878365;6355.428011478804;6431.871362572629;6475.870482590416 19:34:06 INFO - PID 28207 | |1;ext.html;840.6679361652151;850.2857599616322;893.3344658229618;907.9546022698868;919.6597259014162;43732.344014839764;44134.33798493025;44232.557674423246;44415.555844441544;44415.55584444159;40486.392704109465;40722;40827;40887.182256354856;40990.79504602473;7013.719451221945;7095.574265544084;7120.038794762692;7121.715131394738;7156.606386648732;7076.433885289191;7149.142102947628;7175.820604484904;7179.605121718303;7181.533200341961;7079.115110611174;7079.85840283194;7741.419393545479;7976.6809327626825;8001.679932802681;7904.723334683287;7969.561674107922;7982;7992.440529162961;7995.240452157036;7678.961605191994;7792.259735325135;7867.0952840423515;7874.330681892046;7888.684452621888;40845.59154408448;40878.79560602178;41182;41208.58791412078;41230.1753964922;3605.801680907549;3651.068977410743;3659.3779057560278;3661.7986010769396;3669.284489524544;32006.19984500383;32063.51904721431;32105.678943210503;32136.5179522305;32292.838535807405;5141.974290128563;5152.124138896396;5153.613478989091;5173.637845350827;5176.404713457963;191676;192251;192378;192920.0353998235;192974;49899.25151122736;49931.75034124806;50169.498305017216;50943.74528127335;52147.47852521502;53696;53733.46266537363;53823.19265211025;53891.19163212555;53895.84416623291;17048.403305884236;17122.914385427994;17142.142892855558;17177.398791042502;17210.225539850737;13175.407106680223;13398.933005334911;13400.597982060553;13412.731745365038;13452.1256118352;15000.399984000736;15007.699846003019;15082.773758393632;15232.46686365994;15286.770698439532;5581.293292175148;5849.636459036071;5874.647521148745;5881.470667639933;5984.251968503937;988.8318985772436;1007.7178390050798;1013.1185868294631;1040.0639424517842;1044.5717255925035;23831.470043390647;23914.760852391602;24231.878840605685;24386.390340241636;30754.846225768728;1108.8281316395971;1123.685368096934;1123.8876112388696;1126.380490730095;1141.7316930521322;13264.668383290302;13453.394597243148;13476.663083422993;13535;13584.796228056586;230746;234900;235051;235192;235522;48360.75819620879;49245;58337;58736.11895821566;59254.40745592575;1499.5351441053308;1507.7286088504175;1512.6218445388654;1520.5210358737183;1523.9923800380927;27980.572928885344;28369.574456383583;28633.71366286394;28767;29173;40098.59901400949;40428;40466.79766601148;40491;40505;201245;201505;202562;202648;203775;37290.81354593318;37525.81237093797;37667.81166094152;37795;37804.43293350657;44989;45747;46216.768916155204;46392;46406.53593464157;34393.65606343905;34574.82712586421;34743.82628086843;34749.13127171841;35172;33468.49797252994;33796;34020.65979340274;34162.82918585391;34488.31023379569;36776;36922;36975.81512092422;37040.81479592585;37157.25685486329;32879.34241315113;32916.50625240671;35233.82383088068;36005.45991810073;36712.63287367092;25193.600927286254;25542.74457255404;25723.228303150936;26182.34544136412;26308.736912631393 19:34:06 INFO - PID 28207 | |2;jquery.html;591.3613297638551;595.9195508606339;596.1981135372924;602.7890238416553;604.1179877379027;16602.25289861956;22633.434164145903;23570;23623.76376236237;23632.645510317336;19568.217271309168;19740;24919.37701557462;25663.230103096936;25731;6337.55637105404;6519.478441724651;6539.117219175398;6584.045313429549;6587.505937054716;6136;6355.142055822451;6421.7752378666755;6473.741050358004;6474.15835941327;6388.5528013038875;6415.743370265207;6416.101745755598;6416.165898433197;6418.839529011789;6397.328280530523;6399.2640846302575;6401.9359806402035;6402.6158430494315;6404.743810247584;5950.672713000783;5951.613145145595;5963.254593175853;5970.432808883149;5971.731272092767;27630;28990.420191596262;29231.56152657712;29262;29541.70458295411;1904.7428597139346;1957.6574099532525;1957.980420195794;1963.1264087481077;1965.1255191439816;18741.7188742169;19403.80596194048;19472.70790938137;19573.706394404096;19801.900990494956;2428.2836563213896;2457.6436416719653;2473.6042233242774;2480.2435257246534;2485.9005639774387;131418;136141.31929340388;137584;138345.99999999898;138987;14393.280335983369;14839.258037098318;15152.31814568347;15237.942877711366;15288.38846446152;23158.305250842503;23201.3039608812;23205.3038408848;23234.1868034618;23282.185123520594;10142.543585538668;10364.067233948981;10436.799768026622;10636.361818290927;10664.200184986157;9733.659321923698;9776.511174441392;9816.65641702537;9835.60657573689;9891.60433582663;7853.214678532101;9019.819603607892;9152;9213.12475314844;9361.157495825408;2584.98707506465;2635.6705411823523;2645.9680724517452;2648.7616114549396;2736.4277579075606;937.4937533731845;939.8167357365385;967.4437198610827;972.4019727867311;974.7191571722062;19163.466922646156;19494.707579386322;19751.40745777629;19844.107015184352;19897.403077907686;1015.1777060580953;1033.8604288420968;1038.413296487482;1049.5906596427399;1049.6693541534391;10825.296355736851;11043.889561104446;11044.171687123498;11113.222074454872;11135.554577816958;464611;465003;500908;502059;505996;111396.44301778439;120300.3984980087;120523;121017;121786;1220.5666988219232;1245.4768997021272;1269.5683467620868;1283.7175821319295;1287.3305880942046;20395;20467.385978420672;20693;20917.790822091585;21629.567408652052;57493;58803.41196587979;58845;59804;61075;66053;66449;66632;66690.33309666842;66693.66653166703;12590.685232869251;14698.338574763948;14930.178840163895;14960.850391495946;15021.6995660084;23232.65151022702;23296.184633537745;23337.18319858797;23669.17157899534;23671.763282367643;17961.640767184843;18339.816601833812;18550.536236594195;18551.81448185501;18784.060796959824;16629.667406652043;17088.231029603947;17162;17191.484255472355;17320.220590073728;17764.111794410488;18420.631587368447;18729.157187926303;18809.341673041377;18892.14985325636;14300.928495357457;14747.631309217355;14938.626534336729;14954.102753834804;14994.925025374803;17383.217755200792;17386.21762020687;17430.738538921672;17559.736603951205;17969.460916172015 19:34:06 INFO - PID 28207 | |3;mootools.html;1331.3942156318874;1386.2444967492718;1402.6843960108984;1403.7753959366503;1422.6585619451334;13702.794458083124;13927.791083133736;14305.642358941019;14314.212718300489;14326.283685815719;14536.127832330041;14830.851691483082;14844.851551484482;14851.331690073946;14853.777193342108;2737.835729856215;2782.707815679355;2783.6102945587636;2784.651918510186;2785.331520435091;2518.5718427867305;2543.898244070235;2595.7534034266714;2613.7255588163252;2749.2989287731602;2725.6047873058396;2754.4353407551403;2757.214193954723;2760.5997130416076;2762.8066035377433;2635.1304069657062;2667.2665017120253;2669.1191906670847;2671.105179764781;2673.345030467548;2597.480503899209;2598.4413351129597;2616.882240299191;2618.7512186342456;2623.5933430318332;13845.30773461333;14152;14177.503787367496;14191.148531088167;14203.64490887736;7554.69781208751;7819.29626333627;7874.251946065115;7891.2897839194175;7893.8026549336155;4935.876603084916;5033.345665063555;5056.367954005749;5195.9740201298755;5245.973770131125;1810.6378724255069;1824.3705921457076;1833.9449816505394;1856.9535761605932;1861.3950466098572;23426.53146937052;23511.29466116019;23575.41061473477;23621.645675314885;23639.881800590887;6284.371562843679;6555.836104097436;6593.769218077345;6742.528023038439;6785.694643740945;15950.202489875459;15981.360745570048;16016;16034.599135021484;16062.518124456285;7452.105747310249;7716.614169291513;7765.650545725343;7768.262015108556;7768.7669369918995;7013.088298521262;7043.647817609099;7104.751333703399;7172;7184.892226616605;5056.165732654144;5182.378114626194;5239.842804715865;5269.578433725293;5314.043472174968;1358.483776165051;1385.4665953607935;1453.1644304524941;1518.50648539223;1520.2702702702766;905.2893478619252;914.264017465933;916.7616419730919;920.9125133112343;935.6818681648273;8149.633266503021;8221.095679475253;8233.632311616268;8277.58612069394;8321.417500774887;973.153356579766;1010.3533738407425;1012.3217444312328;1018.2312354172552;1018.3889666200369;4990.10178167926;5334.333208348957;5348.518633322942;5505.532029777433;5586.832395028156;18537.81462185361;19151.13819878109;19467.51331216731;19573.1192096356;19759.50601234952;19435.222591096197;19458.70811937822;19554.608907821763;19560.706589401172;19565.608687826163;10490.16078713701;10759.731006724895;10887.564497420015;10979.505922233358;11037.337759734442;7964.20357964199;8139.766524562561;8166.265036146775;8173.427860049977;8227.465214761021;16430.424935127212;16794.496165115066;17049.232784524975;17258.13709314504;17310.82689173092;17249.137543122542;17394.91302543479;17420.47738567845;17870.106494674954;17876.91061544684;10214.387136771817;10468;10526.473676316;10617.044465998097;10624.787504250025;12765.8085128725;12903.806442903177;12961.481540738265;12975.156614820384;12987.090903637032;10480.895191047992;10531.368117912949;10621.415822129857;10704.678859634223;10863.511141998471;10063.849042264226;10183.796324073624;10208.897911021091;10267.94866025665;10489.737756556147;9349.345545812;9405.811883762422;9464.95267523658;9469.526523673927;9495.28785341116;7277.781666550012;7290.234525374972;7363.300486453778;7374.410047196104;7446.367058800062;7299.708011679473;7382.187959324363;7451.962740186264;7484.850302994018;7507.512011719221 19:34:06 INFO - PID 28207 | |4;prototype.html;494.69081823860085;506.40497415536737;532.1698150884619;539.4901817782195;539.6303532080527;6286.779962701306;6303.495720342373;6317.083408286863;6326.873462530747;6359.58662686925;5982;6044.15653225766;6113.969430152854;6162.352952939944;6162.9831077872095;4984.77568509418;4989.2017277235645;5027.421846487646;5031.496850314958;5084.618653600985;5044.974775126119;5054.772535235923;5059.139946209135;5061.54446099851;5082;5012.398512178525;5118.718470484122;5240.213967904807;5260.184671375943;5267.420583735786;5116.872078198037;5153.6907785532985;5222.033923724123;5237.292965449654;5239.13554263546;4857.951420485821;4900.774806298426;4910.21436570147;4911.557959783637;4919.385076865392;6163.753449862;6173.456635841039;6197.411245931629;6254.968725156391;6258.24901011877;6063.939360606381;6095.293317871004;6109.663968481732;6110.419510146529;6121.877562448726;6669.466442684574;6677.799666010027;6709.429698475636;6723.159605049369;6739.258681545026;5262.973685131588;5281.815136470205;5281.86795330116;5325.227841962933;5346.679199248058;6954.4436445084275;7040.929590704079;7068.752593659197;7080.362767350963;7114.786556403316;5522.779088836482;5595;5597.552195824324;5598.944010559923;5612.887742245214;5601.067631667069;5624.775008999676;5637.351704553947;5691.345495268097;5710.743016564182;5956.374580668968;5983.401659834069;6024.27708674953;6038.426349496791;6044.667543285073;6580.63806490638;6637.402633762985;6674.332566743286;6716.429103526158;6719.563228390139;1855.3135339924315;1882.7458293130253;1893.4225061356144;1943.679292916681;1988.0656091636909;1429.2348949047916;1430.306301443799;1432.8567143285798;1457.2859298943442;1484.4952716076587;5659.122835960433;5681.659100453986;5759.337676167211;5778.017736984722;5782.219400380979;6532.771353002622;6595.307492713292;6688.765893193715;6715.3620406061345;6784.253732089466;5677.574181936371;5748.166515855178;5753.913691294634;5759.452851979056;5775.047117225611;3512.4028915084496;3586.1751797086818;3610.98194509031;3624.7281453891064;3632.328019316435;6422.518311126684;6525.282218955911;6537.901931471032;6573.868522629521;6580.934190658128;6754.615303862696;6774.661266936633;6844.555103918229;6896.586204827626;6988.720451181997;6465.482761378984;6465.903011454832;6540.8364790880605;6547.202622478951;6588.967055164693;6724.226713927961;6732.899006515004;6757.391834734897;6757.831054223684;6834.1457317835275;6589.769358072444;6734.427573656294;6756.189257289157;6783.796486105227;6828.487863410165;6648.867022659423;6667.333266673294;6678.699458524476;6684.933150668431;6708.429783468265;5034.798608055637;5047.4952504749235;5059.645824792229;5075.264086707333;5079.212722028092;6827.941669041306;6852.657367131723;6873.175218973755;6879.793606191823;6885.931140688529;6325.841853953688;6350.809475715736;6416.679166041586;6438.420542151229;6535.705893234911;6424.582402143846;6453.548251622341;6461.030845373231;6517.73929042833;6594.406503414716;6325.525585581192;6374.458171055512;6386.425221730066;6465.674536720056;6517.674116294261;6578.046183303299;6578.440832529097;6581.572197807127;6609.405153536205;6613.404793568602;6411.493299074807;6429.5499315049365;6451.612903225821;6495.675216239264;6515.706793194223 19:34:06 INFO - PID 28207 | |5;yui.html;910.0762725833281;929.2612373163334;941.8257622339872;942.7878727286361;950.1306304731169;18451.815481845177;19213.99999999998;19223.03884805761;19261.03694815259;21603.351899443;18948;19080.618387632272;19091;19147.712784308245;19160.808391916078;999.8850132234795;1040.4225654761603;1045.5869931377101;1045.9581616735359;1049.2130901823632;1045.9581616735322;1051.647698021164;1052.4264275969576;1053.010170439788;1054.346305290717;1017.8524114003465;1104.6520346090995;1106.4799544214206;1108.451316598285;1114.0140975236934;1094.1192340166124;1095.3263742798201;1095.61105807438;1101.0640955188105;1101.5924108079982;788.9447738658296;791.4262159934059;792.0218530115303;792.4373694676786;792.4848848248627;20449.182032718672;20479.590408191903;20589;20685.379438616867;20781.5843683127;21671.67492487614;21859;22312.442188945242;22343.888280558494;22548.774512254833;16597;16621.6675666486;16711.247993840305;16849.663006739796;16860.578485537837;3734.850605975758;3754.793486358249;3766.4162054881535;3770.340190466685;3770.472133901256;123829.38085309605;124705.37647311795;124789.37605312007;125396.37301813524;126311.99999999908;16968.406105786486;17027.574310642085;17246.482605521855;17454.825451745575;17595.73606395905;30867.536986945215;31045.223869402995;31152.53271200934;31417.214569635486;31685.683143168273;7795.922040779633;8148.633311500997;8183.918160818434;8854.29165666745;8961.731148065568;4122.361034039729;4414.404055452537;4418.889527761768;4426.601605855424;4430.756308403069;5285.947140528622;5384.273123128328;5402.162664786964;5408.91886621701;5410.648307859977;1053;1067.3062509368972;1081.3457857995957;1085.777415629794;1085.9891401086047;525.7397588193869;554.9472800083986;565.4684596479296;569.4362581044736;569.9116636921284;10762.94618526918;10965.287256328313;11111.944440277746;11769.470373833197;11983.580574679845;469.86608816487137;481.662836014791;539.9028174928472;550.1664977559001;550.499045868258;4892.559669629751;5076.162433198555;5120.692758434506;5255.684658920477;5282.788688452419;96085.5195724031;98246;98516;98935.50532247292;102926;84017.57991210127;85481;85648.57175714082;86439;90399.54800225957;76979.61510192526;77674.2232577667;78971.21028789754;81073.18926810774;82438.17561824305;10442.112420444348;10455.94772026135;10610.469476526298;10847.24069315172;10894.78210435771;35994.28011439809;36732.44901326536;37270.06824829401;37331.52157622886;37412.812935935144;63018.684906575174;65631.34368656443;66680.96076270669;66732.666336668;70215;16410.507684769476;16477.83522164763;16571.50285491437;16680.082595456883;17013.914930425268;16210.189490525663;17396.652066958337;18663.346782862536;19289.131989060246;19881.105350259564;16463.83536164671;16898.577535561708;16999;17218.397356092475;17361.218745156246;16869.325226990783;17042.573935651213;17177.828221717624;17215.913920430317;17942.910285448488;15770.448034318744;16433.09617970975;16640.83359166393;16812;17046.744298835278;12553.497860085494;12729.29988850622;12926.224426534438;13139.737205256033;13663.863361366657;11795.941020294844;12618.810717839056;12819.038572106943;13093.869061309646;13146.671333216364 19:34:06 INFO - PID 28207 | __end_tp_report 19:34:06 INFO - PID 28207 | __start_cc_report 19:34:06 INFO - PID 28207 | _x_x_mozilla_cycle_collect,368 19:34:06 INFO - PID 28207 | __end_cc_report 19:34:06 INFO - PID 28207 | __startTimestamp1502073246813__endTimestamp 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | ------- Summary: start ------- 19:34:06 INFO - PID 28207 | Number of tests: 6 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#0] dojo.html Cycles:165 Average:6153.93 Median:6431.87 stddev:724.34 (11.3%) stddev-sans-first:686.88 19:34:06 INFO - PID 28207 | Values: 3139.7 3151.3 3181.9 3185.3 3221.4 6223.3 6252.9 6299.1 6323.2 6344.2 6011.2 6162.3 6177.6 6186.3 6191.5 5650.9 5664.1 5685.9 5697.5 5734.9 5661.1 5709.5 5721.0 5767.1 5789.3 5793.9 5794.1 5797.6 5801.5 5830.7 5611.1 5667.6 5760.5 5770.4 5784.7 5475.1 5567.1 5634.0 5656.9 5659.5 6085.8 6141.7 6144.8 6213.7 6233.8 6534.1 6624.8 6715.4 6719.5 6749.6 6699.9 6730.4 6755.3 6808.4 6827.9 6257.7 6284.6 6285.5 6290.4 6295.2 6904.9 6975.5 6982.1 6991.4 6997.2 6559.4 6571.6 6585.7 6663.5 6681.6 6460.6 6584.2 6625.9 6634.2 6693.3 6538.8 6541.2 6588.5 6593.6 6654.9 6656.6 6658.2 6663.3 6678.6 6681.6 5367.5 5369.0 5388.2 5399.5 5406.8 4611.1 4681.8 4698.9 4713.3 4738.8 5650.2 5754.9 5829.5 5841.4 5853.8 6697.7 6714.5 6716.1 6717.9 6744.1 5727.2 5738.1 5772.4 5798.9 5801.9 5780.8 5890.9 5893.6 5898.3 5956.3 6421.1 6448.0 6477.8 6486.5 6490.5 6237.1 6741.8 6755.2 6798.1 6838.5 6446.3 6449.7 6459.2 6536.5 6541.7 6464.4 6544.9 6556.6 6588.0 6660.9 6692.8 6754.9 6757.7 6762.8 6768.1 6454.6 6504.8 6514.9 6535.2 6540.8 6522.6 6528.5 6544.8 6545.6 6546.2 6415.8 6422.1 6434.7 6454.7 6455.7 6533.3 6557.3 6570.8 6628.9 6677.1 6292.1 6319.8 6355.4 6431.9 6475.9 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#1] ext.html Cycles:180 Average:39070.46 Median:36948.91 stddev:54468.66 (147.4%) stddev-sans-first:54545.81 19:34:06 INFO - PID 28207 | Values: 840.7 850.3 893.3 908.0 919.7 43732.3 44134.3 44232.6 44415.6 44415.6 40486.4 40722.0 40827.0 40887.2 40990.8 7013.7 7095.6 7120.0 7121.7 7156.6 7076.4 7149.1 7175.8 7179.6 7181.5 7079.1 7079.9 7741.4 7976.7 8001.7 7904.7 7969.6 7982.0 7992.4 7995.2 7679.0 7792.3 7867.1 7874.3 7888.7 40845.6 40878.8 41182.0 41208.6 41230.2 3605.8 3651.1 3659.4 3661.8 3669.3 32006.2 32063.5 32105.7 32136.5 32292.8 5142.0 5152.1 5153.6 5173.6 5176.4 191676.0 192251.0 192378.0 192920.0 192974.0 49899.3 49931.8 50169.5 50943.7 52147.5 53696.0 53733.5 53823.2 53891.2 53895.8 17048.4 17122.9 17142.1 17177.4 17210.2 13175.4 13398.9 13400.6 13412.7 13452.1 15000.4 15007.7 15082.8 15232.5 15286.8 5581.3 5849.6 5874.6 5881.5 5984.3 988.8 1007.7 1013.1 1040.1 1044.6 23831.5 23914.8 24231.9 24386.4 30754.8 1108.8 1123.7 1123.9 1126.4 1141.7 13264.7 13453.4 13476.7 13535.0 13584.8 230746.0 234900.0 235051.0 235192.0 235522.0 48360.8 49245.0 58337.0 58736.1 59254.4 1499.5 1507.7 1512.6 1520.5 1524.0 27980.6 28369.6 28633.7 28767.0 29173.0 40098.6 40428.0 40466.8 40491.0 40505.0 201245.0 201505.0 202562.0 202648.0 203775.0 37290.8 37525.8 37667.8 37795.0 37804.4 44989.0 45747.0 46216.8 46392.0 46406.5 34393.7 34574.8 34743.8 34749.1 35172.0 33468.5 33796.0 34020.7 34162.8 34488.3 36776.0 36922.0 36975.8 37040.8 37157.3 32879.3 32916.5 35233.8 36005.5 36712.6 25193.6 25542.7 25723.2 26182.3 26308.7 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#2] jquery.html Cycles:180 Average:34669.01 Median:23203.30 stddev:82288.20 (354.6%) stddev-sans-first:82479.26 19:34:06 INFO - PID 28207 | Values: 591.4 595.9 596.2 602.8 604.1 16602.3 22633.4 23570.0 23623.8 23632.6 19568.2 19740.0 24919.4 25663.2 25731.0 6337.6 6519.5 6539.1 6584.0 6587.5 6136.0 6355.1 6421.8 6473.7 6474.2 6388.6 6415.7 6416.1 6416.2 6418.8 6397.3 6399.3 6401.9 6402.6 6404.7 5950.7 5951.6 5963.3 5970.4 5971.7 27630.0 28990.4 29231.6 29262.0 29541.7 1904.7 1957.7 1958.0 1963.1 1965.1 18741.7 19403.8 19472.7 19573.7 19801.9 2428.3 2457.6 2473.6 2480.2 2485.9 131418.0 136141.3 137584.0 138346.0 138987.0 14393.3 14839.3 15152.3 15237.9 15288.4 23158.3 23201.3 23205.3 23234.2 23282.2 10142.5 10364.1 10436.8 10636.4 10664.2 9733.7 9776.5 9816.7 9835.6 9891.6 7853.2 9019.8 9152.0 9213.1 9361.2 2585.0 2635.7 2646.0 2648.8 2736.4 937.5 939.8 967.4 972.4 974.7 19163.5 19494.7 19751.4 19844.1 19897.4 1015.2 1033.9 1038.4 1049.6 1049.7 10825.3 11043.9 11044.2 11113.2 11135.6 464611.0 465003.0 500908.0 502059.0 505996.0 111396.4 120300.4 120523.0 121017.0 121786.0 1220.6 1245.5 1269.6 1283.7 1287.3 20395.0 20467.4 20693.0 20917.8 21629.6 57493.0 58803.4 58845.0 59804.0 61075.0 66053.0 66449.0 66632.0 66690.3 66693.7 12590.7 14698.3 14930.2 14960.9 15021.7 23232.7 23296.2 23337.2 23669.2 23671.8 17961.6 18339.8 18550.5 18551.8 18784.1 16629.7 17088.2 17162.0 17191.5 17320.2 17764.1 18420.6 18729.2 18809.3 18892.1 14300.9 14747.6 14938.6 14954.1 14994.9 17383.2 17386.2 17430.7 17559.7 17969.5 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#3] mootools.html Cycles:180 Average:8791.42 Median:2569.83 stddev:5983.65 (232.8%) stddev-sans-first:5974.18 19:34:06 INFO - PID 28207 | Values: 1331.4 1386.2 1402.7 1403.8 1422.7 13702.8 13927.8 14305.6 14314.2 14326.3 14536.1 14830.9 14844.9 14851.3 14853.8 2737.8 2782.7 2783.6 2784.7 2785.3 2518.6 2543.9 2595.8 2613.7 2749.3 2725.6 2754.4 2757.2 2760.6 2762.8 2635.1 2667.3 2669.1 2671.1 2673.3 2597.5 2598.4 2616.9 2618.8 2623.6 13845.3 14152.0 14177.5 14191.1 14203.6 7554.7 7819.3 7874.3 7891.3 7893.8 4935.9 5033.3 5056.4 5196.0 5246.0 1810.6 1824.4 1833.9 1857.0 1861.4 23426.5 23511.3 23575.4 23621.6 23639.9 6284.4 6555.8 6593.8 6742.5 6785.7 15950.2 15981.4 16016.0 16034.6 16062.5 7452.1 7716.6 7765.7 7768.3 7768.8 7013.1 7043.6 7104.8 7172.0 7184.9 5056.2 5182.4 5239.8 5269.6 5314.0 1358.5 1385.5 1453.2 1518.5 1520.3 905.3 914.3 916.8 920.9 935.7 8149.6 8221.1 8233.6 8277.6 8321.4 973.2 1010.4 1012.3 1018.2 1018.4 4990.1 5334.3 5348.5 5505.5 5586.8 18537.8 19151.1 19467.5 19573.1 19759.5 19435.2 19458.7 19554.6 19560.7 19565.6 10490.2 10759.7 10887.6 10979.5 11037.3 7964.2 8139.8 8166.3 8173.4 8227.5 16430.4 16794.5 17049.2 17258.1 17310.8 17249.1 17394.9 17420.5 17870.1 17876.9 10214.4 10468.0 10526.5 10617.0 10624.8 12765.8 12903.8 12961.5 12975.2 12987.1 10480.9 10531.4 10621.4 10704.7 10863.5 10063.8 10183.8 10208.9 10267.9 10489.7 9349.3 9405.8 9465.0 9469.5 9495.3 7277.8 7290.2 7363.3 7374.4 7446.4 7299.7 7382.2 7452.0 7484.9 7507.5 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#4] prototype.html Cycles:180 Average:5639.85 Median:6168.61 stddev:1515.54 (24.6%) stddev-sans-first:1469.76 19:34:06 INFO - PID 28207 | Values: 494.7 506.4 532.2 539.5 539.6 6286.8 6303.5 6317.1 6326.9 6359.6 5982.0 6044.2 6114.0 6162.4 6163.0 4984.8 4989.2 5027.4 5031.5 5084.6 5045.0 5054.8 5059.1 5061.5 5082.0 5012.4 5118.7 5240.2 5260.2 5267.4 5116.9 5153.7 5222.0 5237.3 5239.1 4858.0 4900.8 4910.2 4911.6 4919.4 6163.8 6173.5 6197.4 6255.0 6258.2 6063.9 6095.3 6109.7 6110.4 6121.9 6669.5 6677.8 6709.4 6723.2 6739.3 5263.0 5281.8 5281.9 5325.2 5346.7 6954.4 7040.9 7068.8 7080.4 7114.8 5522.8 5595.0 5597.6 5598.9 5612.9 5601.1 5624.8 5637.4 5691.3 5710.7 5956.4 5983.4 6024.3 6038.4 6044.7 6580.6 6637.4 6674.3 6716.4 6719.6 1855.3 1882.7 1893.4 1943.7 1988.1 1429.2 1430.3 1432.9 1457.3 1484.5 5659.1 5681.7 5759.3 5778.0 5782.2 6532.8 6595.3 6688.8 6715.4 6784.3 5677.6 5748.2 5753.9 5759.5 5775.0 3512.4 3586.2 3611.0 3624.7 3632.3 6422.5 6525.3 6537.9 6573.9 6580.9 6754.6 6774.7 6844.6 6896.6 6988.7 6465.5 6465.9 6540.8 6547.2 6589.0 6724.2 6732.9 6757.4 6757.8 6834.1 6589.8 6734.4 6756.2 6783.8 6828.5 6648.9 6667.3 6678.7 6684.9 6708.4 5034.8 5047.5 5059.6 5075.3 5079.2 6827.9 6852.7 6873.2 6879.8 6885.9 6325.8 6350.8 6416.7 6438.4 6535.7 6424.6 6453.5 6461.0 6517.7 6594.4 6325.5 6374.5 6386.4 6465.7 6517.7 6578.0 6578.4 6581.6 6609.4 6613.4 6411.5 6429.5 6451.6 6495.7 6515.7 19:34:06 INFO - PID 28207 | 19:34:06 INFO - PID 28207 | [#5] yui.html Cycles:180 Average:22452.99 Median:19242.04 stddev:30023.28 (156.0%) stddev-sans-first:30063.92 19:34:06 INFO - PID 28207 | Values: 910.1 929.3 941.8 942.8 950.1 18451.8 19214.0 19223.0 19261.0 21603.4 18948.0 19080.6 19091.0 19147.7 19160.8 999.9 1040.4 1045.6 1046.0 1049.2 1046.0 1051.6 1052.4 1053.0 1054.3 1017.9 1104.7 1106.5 1108.5 1114.0 1094.1 1095.3 1095.6 1101.1 1101.6 788.9 791.4 792.0 792.4 792.5 20449.2 20479.6 20589.0 20685.4 20781.6 21671.7 21859.0 22312.4 22343.9 22548.8 16597.0 16621.7 16711.2 16849.7 16860.6 3734.9 3754.8 3766.4 3770.3 3770.5 123829.4 124705.4 124789.4 125396.4 126312.0 16968.4 17027.6 17246.5 17454.8 17595.7 30867.5 31045.2 31152.5 31417.2 31685.7 7795.9 8148.6 8183.9 8854.3 8961.7 4122.4 4414.4 4418.9 4426.6 4430.8 5285.9 5384.3 5402.2 5408.9 5410.6 1053.0 1067.3 1081.3 1085.8 1086.0 525.7 554.9 565.5 569.4 569.9 10762.9 10965.3 11111.9 11769.5 11983.6 469.9 481.7 539.9 550.2 550.5 4892.6 5076.2 5120.7 5255.7 5282.8 96085.5 98246.0 98516.0 98935.5 102926.0 84017.6 85481.0 85648.6 86439.0 90399.5 76979.6 77674.2 78971.2 81073.2 82438.2 10442.1 10455.9 10610.5 10847.2 10894.8 35994.3 36732.4 37270.1 37331.5 37412.8 63018.7 65631.3 66681.0 66732.7 70215.0 16410.5 16477.8 16571.5 16680.1 17013.9 16210.2 17396.7 18663.3 19289.1 19881.1 16463.8 16898.6 16999.0 17218.4 17361.2 16869.3 17042.6 17177.8 17215.9 17942.9 15770.4 16433.1 16640.8 16812.0 17046.7 12553.5 12729.3 12926.2 13139.7 13663.9 11795.9 12618.8 12819.0 13093.9 13146.7 19:34:06 INFO - PID 28207 | -------- Summary: end -------- 19:34:06 INFO - PID 28207 | 19:34:07 INFO - TEST-INFO | 28207: exit 0 19:34:07 INFO - TEST-OK | dromaeo_css | took 1114907ms 19:34:07 INFO - TEST-START | kraken 19:34:07 INFO - Initialising browser for kraken test... 19:34:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49435/getInfo.html -profile /tmp/tmp9FFDnc/profile 19:34:07 INFO - TEST-INFO | started process 28582 (/builds/slave/test/build/application/firefox/firefox http://localhost:49435/getInfo.html) 19:34:14 INFO - TEST-INFO | 28582: exit 0 19:34:14 INFO - Browser initialized. 19:34:14 INFO - Running cycle 1/1 for kraken test... 19:34:14 INFO - TEST-INFO | started process 28807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9FFDnc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:15 INFO - PID 28807 | 19:34:15 INFO - PID 28807 | (/builds/slave/test/build/application/firefox/firefox:28860): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:34:15 INFO - PID 28807 | 19:34:25 INFO - PID 28807 | RSS: Main: 174268416 19:34:25 INFO - PID 28807 | 19:34:25 INFO - PID 28807 | serialization: Helvetica 19:34:25 INFO - PID 28807 | serialization: Arial 19:34:28 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-beat-detection) 19:34:29 INFO - PID 28807 | RSS: Main: 178147328 19:34:29 INFO - PID 28807 | 19:34:29 INFO - PID 28807 | serialization: Helvetica 19:34:29 INFO - PID 28807 | serialization: Arial 19:34:32 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-dft) 19:34:32 INFO - PID 28807 | RSS: Main: 179318784 19:34:32 INFO - PID 28807 | 19:34:32 INFO - PID 28807 | serialization: Helvetica 19:34:32 INFO - PID 28807 | serialization: Arial 19:34:35 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-fft) 19:34:36 INFO - PID 28807 | RSS: Main: 174186496 19:34:36 INFO - PID 28807 | 19:34:36 INFO - PID 28807 | serialization: Helvetica 19:34:36 INFO - PID 28807 | serialization: Arial 19:34:38 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-oscillator) 19:34:39 INFO - PID 28807 | RSS: Main: 174604288 19:34:39 INFO - PID 28807 | 19:34:39 INFO - PID 28807 | serialization: Helvetica 19:34:39 INFO - PID 28807 | serialization: Arial 19:34:41 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:34:42 INFO - PID 28807 | RSS: Main: 175108096 19:34:42 INFO - PID 28807 | 19:34:42 INFO - PID 28807 | serialization: Helvetica 19:34:42 INFO - PID 28807 | serialization: Arial 19:34:45 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-darkroom) 19:34:45 INFO - PID 28807 | RSS: Main: 177074176 19:34:45 INFO - PID 28807 | 19:34:46 INFO - PID 28807 | serialization: Helvetica 19:34:46 INFO - PID 28807 | serialization: Arial 19:34:49 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-desaturate) 19:34:50 INFO - PID 28807 | RSS: Main: 176214016 19:34:50 INFO - PID 28807 | 19:34:50 INFO - PID 28807 | serialization: Helvetica 19:34:50 INFO - PID 28807 | serialization: Arial 19:34:52 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49435/tests/kraken/driver.html?testName=json-parse-financial) 19:34:53 INFO - PID 28807 | RSS: Main: 177545216 19:34:53 INFO - PID 28807 | 19:34:53 INFO - PID 28807 | serialization: Helvetica 19:34:53 INFO - PID 28807 | serialization: Arial 19:34:55 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:34:55 INFO - PID 28807 | RSS: Main: 177504256 19:34:55 INFO - PID 28807 | 19:34:55 INFO - PID 28807 | serialization: Helvetica 19:34:55 INFO - PID 28807 | serialization: Arial 19:34:57 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:34:58 INFO - PID 28807 | RSS: Main: 174534656 19:34:58 INFO - PID 28807 | 19:34:58 INFO - PID 28807 | serialization: Helvetica 19:34:58 INFO - PID 28807 | serialization: Arial 19:35:00 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:35:01 INFO - PID 28807 | RSS: Main: 174489600 19:35:01 INFO - PID 28807 | 19:35:01 INFO - PID 28807 | serialization: Helvetica 19:35:01 INFO - PID 28807 | serialization: Arial 19:35:04 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:35:04 INFO - PID 28807 | RSS: Main: 174641152 19:35:04 INFO - PID 28807 | 19:35:04 INFO - PID 28807 | serialization: Helvetica 19:35:04 INFO - PID 28807 | serialization: Arial 19:35:07 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:35:08 INFO - PID 28807 | RSS: Main: 174911488 19:35:08 INFO - PID 28807 | 19:35:08 INFO - PID 28807 | serialization: Helvetica 19:35:08 INFO - PID 28807 | serialization: Arial 19:35:10 INFO - PID 28807 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49435/tests/kraken/driver.html?testName=ai-astar) 19:35:10 INFO - PID 28807 | RSS: Main: 176467968 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | __start_tp_report 19:35:10 INFO - PID 28807 | _x_x_mozilla_page_load 19:35:10 INFO - PID 28807 | _x_x_mozilla_page_load_details 19:35:10 INFO - PID 28807 | |i|pagename|runs| 19:35:10 INFO - PID 28807 | |0;ai-astar;97;107;108;106;110;108;108;99;111;107 19:35:10 INFO - PID 28807 | |1;audio-beat-detection;144;133;144;188;120;146;145;118;182;123 19:35:10 INFO - PID 28807 | |2;audio-dft;166;163;163;163;163;166;170;165;161;163 19:35:10 INFO - PID 28807 | |3;audio-fft;73;75;82;168;76;73;79;82;97;77 19:35:10 INFO - PID 28807 | |4;audio-oscillator;79;78;139;79;78;78;130;81;84;126 19:35:10 INFO - PID 28807 | |5;imaging-gaussian-blur;114;114;114;114;122;116;117;115;124;114 19:35:10 INFO - PID 28807 | |6;imaging-darkroom;151;153;150;152;151;150;150;158;150;150 19:35:10 INFO - PID 28807 | |7;imaging-desaturate;99;96;94;94;94;94;94;94;99;94 19:35:10 INFO - PID 28807 | |8;json-parse-financial;55;54;54;54;57;55;56;54;54;53 19:35:10 INFO - PID 28807 | |9;json-stringify-tinderbox;54;55;54;54;54;59;54;54;54;54 19:35:10 INFO - PID 28807 | |10;stanford-crypto-aes;79;82;83;79;98;79;79;97;87;92 19:35:10 INFO - PID 28807 | |11;stanford-crypto-ccm;128;139;128;127;128;131;125;128;132;171 19:35:10 INFO - PID 28807 | |12;stanford-crypto-pbkdf2;188;179;177;173;178;174;170;172;171;170 19:35:10 INFO - PID 28807 | |13;stanford-crypto-sha256-iterative;67;65;67;65;73;64;67;65;66;66 19:35:10 INFO - PID 28807 | __end_tp_report 19:35:10 INFO - PID 28807 | __start_cc_report 19:35:10 INFO - PID 28807 | _x_x_mozilla_cycle_collect,1013 19:35:10 INFO - PID 28807 | __end_cc_report 19:35:10 INFO - PID 28807 | __startTimestamp1502073310670__endTimestamp 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | ------- Summary: start ------- 19:35:10 INFO - PID 28807 | Number of tests: 14 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#0] ai-astar Cycles:10 Average:106.10 Median:109.00 stddev:4.53 (4.2%) stddev-sans-first:3.41 19:35:10 INFO - PID 28807 | Values: 97.0 107.0 108.0 106.0 110.0 108.0 108.0 99.0 111.0 107.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:144.50 stddev:24.03 (16.6%) stddev-sans-first:25.49 19:35:10 INFO - PID 28807 | Values: 144.0 133.0 144.0 188.0 120.0 146.0 145.0 118.0 182.0 123.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.54 (1.5%) stddev-sans-first:2.62 19:35:10 INFO - PID 28807 | Values: 166.0 163.0 163.0 163.0 163.0 166.0 170.0 165.0 161.0 163.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#3] audio-fft Cycles:10 Average:88.20 Median:78.00 stddev:28.90 (37.1%) stddev-sans-first:30.13 19:35:10 INFO - PID 28807 | Values: 73.0 75.0 82.0 168.0 76.0 73.0 79.0 82.0 97.0 77.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:78.50 stddev:25.42 (32.4%) stddev-sans-first:26.28 19:35:10 INFO - PID 28807 | Values: 79.0 78.0 139.0 79.0 78.0 78.0 130.0 81.0 84.0 126.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:115.50 stddev:3.66 (3.2%) stddev-sans-first:3.77 19:35:10 INFO - PID 28807 | Values: 114.0 114.0 114.0 114.0 122.0 116.0 117.0 115.0 124.0 114.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:2.51 (1.7%) stddev-sans-first:2.65 19:35:10 INFO - PID 28807 | Values: 151.0 153.0 150.0 152.0 151.0 150.0 150.0 158.0 150.0 150.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.10 (2.2%) stddev-sans-first:1.72 19:35:10 INFO - PID 28807 | Values: 99.0 96.0 94.0 94.0 94.0 94.0 94.0 94.0 99.0 94.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.17 (2.2%) stddev-sans-first:1.24 19:35:10 INFO - PID 28807 | Values: 55.0 54.0 54.0 54.0 57.0 55.0 56.0 54.0 54.0 53.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.00 stddev:1.58 (2.9%) stddev-sans-first:1.66 19:35:10 INFO - PID 28807 | Values: 54.0 55.0 54.0 54.0 54.0 59.0 54.0 54.0 54.0 54.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.00 stddev:7.60 (8.9%) stddev-sans-first:7.69 19:35:10 INFO - PID 28807 | Values: 79.0 82.0 83.0 79.0 98.0 79.0 79.0 97.0 87.0 92.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:129.50 stddev:13.66 (10.6%) stddev-sans-first:14.34 19:35:10 INFO - PID 28807 | Values: 128.0 139.0 128.0 127.0 128.0 131.0 125.0 128.0 132.0 171.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.50 stddev:5.55 (3.2%) stddev-sans-first:3.46 19:35:10 INFO - PID 28807 | Values: 188.0 179.0 177.0 173.0 178.0 174.0 170.0 172.0 171.0 170.0 19:35:10 INFO - PID 28807 | 19:35:10 INFO - PID 28807 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.51 (3.8%) stddev-sans-first:2.65 19:35:10 INFO - PID 28807 | Values: 67.0 65.0 67.0 65.0 73.0 64.0 67.0 65.0 66.0 66.0 19:35:10 INFO - PID 28807 | -------- Summary: end -------- 19:35:10 INFO - PID 28807 | 19:35:11 INFO - PID 28807 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:35:11 INFO - TEST-INFO | 28807: exit 0 19:35:11 INFO - TEST-OK | kraken | took 64134ms 19:35:11 INFO - SUITE-END | took 1179s 19:35:11 INFO - Completed test suite (00:19:39) 19:35:11 INFO - javascript benchmark 19:35:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.370493821076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.7331226845718, 3151.2752067024585, 3181.85681644326, 3185.2673885006434, 3221.4201443740117, 6223.284322302937, 6252.874942501147, 6299.086632438294, 6323.241211054668, 6344.206974128234, 6011.248593925759, 6162.322144564095, 6177.629342239457, 6186.2885768136675, 6191.535634827384, 5650.943490565093, 5664.065429204176, 5685.914711279334, 5697.544196464273, 5734.942650573504, 5661.065924122536, 5709.514691251228, 5721.0, 5767.1349297605275, 5789.305283366002, 5793.913091303634, 5794.0729483282685, 5797.623154494944, 5801.506871915893, 5830.737616807232, 5611.0741727614895, 5667.603267771257, 5760.510356619692, 5770.422957704238, 5784.68184249866, 5475.0966090595, 5567.081431563787, 5633.971830140864, 5656.943430565724, 5659.490645841894, 6085.847853803646, 6141.692915354214, 6144.78493252734, 6213.720382582795, 6233.844153896143, 6534.117894084333, 6624.768133115318, 6715.395614394728, 6719.496037797136, 6749.5612785168805, 6699.899501507482, 6730.427913627347, 6755.290694477058, 6808.353206445379, 6827.863442731117, 6257.718402671845, 6284.5600807943465, 6285.465735412496, 6290.433860952537, 6295.150154729053, 6904.896426553606, 6975.476839237078, 6982.057422248033, 6991.370776630128, 6997.160340759141, 6559.409653131241, 6571.605703657796, 6585.6707164641575, 6663.4669226461765, 6681.599104053772, 6460.580062295936, 6584.176977877765, 6625.933740662628, 6634.170728658918, 6693.330666933268, 6538.771143009972, 6541.215054193527, 6588.4729221662155, 6593.604383736991, 6654.900176497356, 6656.633885136364, 6658.234303055114, 6663.300353462913, 6678.632675202911, 6681.5656982296, 5367.490088441592, 5368.973155134199, 5388.191771234267, 5399.460053994648, 5406.78372865081, 4611.077784443125, 4681.812727490862, 4698.88252793676, 4713.34013238147, 4738.763061846894, 5650.237217975603, 5754.913676294859, 5829.47534721877, 5841.4450627190345, 5853.824385268449, 6697.665116744241, 6714.462842972551, 6716.059751634775, 6717.899231511531, 6744.089547911068, 5727.169560413717, 5738.139279108167, 5772.3938986406665, 5798.9420105799245, 5801.9129713054335, 5780.797672081541, 5890.911636325459, 5893.646381217055, 5898.321693005273, 5956.285245770535, 6421.068945002949, 6447.967760161357, 6477.805665830033, 6486.481081513562, 6490.545661803629, 6237.12680224778, 6741.764038258638, 6755.1556055493065, 6798.082258894986, 6838.521303508706, 6446.29090800021, 6449.742010319723, 6459.192600924885, 6536.509761767791, 6541.70562324706, 6464.353564643498, 6544.869102618016, 6556.573822701509, 6588.04473351371, 6660.866782664417, 6692.765753198614, 6754.932450675627, 6757.729690812313, 6762.797116086525, 6768.08630834831, 6454.580452270588, 6504.772332968323, 6514.869702606016, 6535.183102112236, 6540.771073012422, 6522.641254731036, 6528.510361722795, 6544.8363790905605, 6545.574537655038, 6546.214454265519, 6415.807525774234, 6422.133012043314, 6434.742610295536, 6454.67726613658, 6455.741770329134, 6533.346665333429, 6557.344265573404, 6570.8028759137305, 6628.900566491603, 6677.131972843499, 6292.087647291209, 6319.8104056878365, 6355.428011478804, 6431.871362572629, 6475.870482590416], "value": 6100.044087136986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.6679361652151, 850.2857599616322, 893.3344658229618, 907.9546022698868, 919.6597259014162, 43732.344014839764, 44134.33798493025, 44232.557674423246, 44415.555844441544, 44415.55584444159, 40486.392704109465, 40722.0, 40827.0, 40887.182256354856, 40990.79504602473, 7013.719451221945, 7095.574265544084, 7120.038794762692, 7121.715131394738, 7156.606386648732, 7076.433885289191, 7149.142102947628, 7175.820604484904, 7179.605121718303, 7181.533200341961, 7079.115110611174, 7079.85840283194, 7741.419393545479, 7976.6809327626825, 8001.679932802681, 7904.723334683287, 7969.561674107922, 7982.0, 7992.440529162961, 7995.240452157036, 7678.961605191994, 7792.259735325135, 7867.0952840423515, 7874.330681892046, 7888.684452621888, 40845.59154408448, 40878.79560602178, 41182.0, 41208.58791412078, 41230.1753964922, 3605.801680907549, 3651.068977410743, 3659.3779057560278, 3661.7986010769396, 3669.284489524544, 32006.19984500383, 32063.51904721431, 32105.678943210503, 32136.5179522305, 32292.838535807405, 5141.974290128563, 5152.124138896396, 5153.613478989091, 5173.637845350827, 5176.404713457963, 191676.0, 192251.0, 192378.0, 192920.0353998235, 192974.0, 49899.25151122736, 49931.75034124806, 50169.498305017216, 50943.74528127335, 52147.47852521502, 53696.0, 53733.46266537363, 53823.19265211025, 53891.19163212555, 53895.84416623291, 17048.403305884236, 17122.914385427994, 17142.142892855558, 17177.398791042502, 17210.225539850737, 13175.407106680223, 13398.933005334911, 13400.597982060553, 13412.731745365038, 13452.1256118352, 15000.399984000736, 15007.699846003019, 15082.773758393632, 15232.46686365994, 15286.770698439532, 5581.293292175148, 5849.636459036071, 5874.647521148745, 5881.470667639933, 5984.251968503937, 988.8318985772436, 1007.7178390050798, 1013.1185868294631, 1040.0639424517842, 1044.5717255925035, 23831.470043390647, 23914.760852391602, 24231.878840605685, 24386.390340241636, 30754.846225768728, 1108.8281316395971, 1123.685368096934, 1123.8876112388696, 1126.380490730095, 1141.7316930521322, 13264.668383290302, 13453.394597243148, 13476.663083422993, 13535.0, 13584.796228056586, 230746.0, 234900.0, 235051.0, 235192.0, 235522.0, 48360.75819620879, 49245.0, 58337.0, 58736.11895821566, 59254.40745592575, 1499.5351441053308, 1507.7286088504175, 1512.6218445388654, 1520.5210358737183, 1523.9923800380927, 27980.572928885344, 28369.574456383583, 28633.71366286394, 28767.0, 29173.0, 40098.59901400949, 40428.0, 40466.79766601148, 40491.0, 40505.0, 201245.0, 201505.0, 202562.0, 202648.0, 203775.0, 37290.81354593318, 37525.81237093797, 37667.81166094152, 37795.0, 37804.43293350657, 44989.0, 45747.0, 46216.768916155204, 46392.0, 46406.53593464157, 34393.65606343905, 34574.82712586421, 34743.82628086843, 34749.13127171841, 35172.0, 33468.49797252994, 33796.0, 34020.65979340274, 34162.82918585391, 34488.31023379569, 36776.0, 36922.0, 36975.81512092422, 37040.81479592585, 37157.25685486329, 32879.34241315113, 32916.50625240671, 35233.82383088068, 36005.45991810073, 36712.63287367092, 25193.600927286254, 25542.74457255404, 25723.228303150936, 26182.34544136412, 26308.736912631393], "value": 17878.040057083977, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.3613297638551, 595.9195508606339, 596.1981135372924, 602.7890238416553, 604.1179877379027, 16602.25289861956, 22633.434164145903, 23570.0, 23623.76376236237, 23632.645510317336, 19568.217271309168, 19740.0, 24919.37701557462, 25663.230103096936, 25731.0, 6337.55637105404, 6519.478441724651, 6539.117219175398, 6584.045313429549, 6587.505937054716, 6136.0, 6355.142055822451, 6421.7752378666755, 6473.741050358004, 6474.15835941327, 6388.5528013038875, 6415.743370265207, 6416.101745755598, 6416.165898433197, 6418.839529011789, 6397.328280530523, 6399.2640846302575, 6401.9359806402035, 6402.6158430494315, 6404.743810247584, 5950.672713000783, 5951.613145145595, 5963.254593175853, 5970.432808883149, 5971.731272092767, 27630.0, 28990.420191596262, 29231.56152657712, 29262.0, 29541.70458295411, 1904.7428597139346, 1957.6574099532525, 1957.980420195794, 1963.1264087481077, 1965.1255191439816, 18741.7188742169, 19403.80596194048, 19472.70790938137, 19573.706394404096, 19801.900990494956, 2428.2836563213896, 2457.6436416719653, 2473.6042233242774, 2480.2435257246534, 2485.9005639774387, 131418.0, 136141.31929340388, 137584.0, 138345.99999999898, 138987.0, 14393.280335983369, 14839.258037098318, 15152.31814568347, 15237.942877711366, 15288.38846446152, 23158.305250842503, 23201.3039608812, 23205.3038408848, 23234.1868034618, 23282.185123520594, 10142.543585538668, 10364.067233948981, 10436.799768026622, 10636.361818290927, 10664.200184986157, 9733.659321923698, 9776.511174441392, 9816.65641702537, 9835.60657573689, 9891.60433582663, 7853.214678532101, 9019.819603607892, 9152.0, 9213.12475314844, 9361.157495825408, 2584.98707506465, 2635.6705411823523, 2645.9680724517452, 2648.7616114549396, 2736.4277579075606, 937.4937533731845, 939.8167357365385, 967.4437198610827, 972.4019727867311, 974.7191571722062, 19163.466922646156, 19494.707579386322, 19751.40745777629, 19844.107015184352, 19897.403077907686, 1015.1777060580953, 1033.8604288420968, 1038.413296487482, 1049.5906596427399, 1049.6693541534391, 10825.296355736851, 11043.889561104446, 11044.171687123498, 11113.222074454872, 11135.554577816958, 464611.0, 465003.0, 500908.0, 502059.0, 505996.0, 111396.44301778439, 120300.3984980087, 120523.0, 121017.0, 121786.0, 1220.5666988219232, 1245.4768997021272, 1269.5683467620868, 1283.7175821319295, 1287.3305880942046, 20395.0, 20467.385978420672, 20693.0, 20917.790822091585, 21629.567408652052, 57493.0, 58803.41196587979, 58845.0, 59804.0, 61075.0, 66053.0, 66449.0, 66632.0, 66690.33309666842, 66693.66653166703, 12590.685232869251, 14698.338574763948, 14930.178840163895, 14960.850391495946, 15021.6995660084, 23232.65151022702, 23296.184633537745, 23337.18319858797, 23669.17157899534, 23671.763282367643, 17961.640767184843, 18339.816601833812, 18550.536236594195, 18551.81448185501, 18784.060796959824, 16629.667406652043, 17088.231029603947, 17162.0, 17191.484255472355, 17320.220590073728, 17764.111794410488, 18420.631587368447, 18729.157187926303, 18809.341673041377, 18892.14985325636, 14300.928495357457, 14747.631309217355, 14938.626534336729, 14954.102753834804, 14994.925025374803, 17383.217755200792, 17386.21762020687, 17430.738538921672, 17559.736603951205, 17969.460916172015], "value": 11965.024132896428, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3942156318874, 1386.2444967492718, 1402.6843960108984, 1403.7753959366503, 1422.6585619451334, 13702.794458083124, 13927.791083133736, 14305.642358941019, 14314.212718300489, 14326.283685815719, 14536.127832330041, 14830.851691483082, 14844.851551484482, 14851.331690073946, 14853.777193342108, 2737.835729856215, 2782.707815679355, 2783.6102945587636, 2784.651918510186, 2785.331520435091, 2518.5718427867305, 2543.898244070235, 2595.7534034266714, 2613.7255588163252, 2749.2989287731602, 2725.6047873058396, 2754.4353407551403, 2757.214193954723, 2760.5997130416076, 2762.8066035377433, 2635.1304069657062, 2667.2665017120253, 2669.1191906670847, 2671.105179764781, 2673.345030467548, 2597.480503899209, 2598.4413351129597, 2616.882240299191, 2618.7512186342456, 2623.5933430318332, 13845.30773461333, 14152.0, 14177.503787367496, 14191.148531088167, 14203.64490887736, 7554.69781208751, 7819.29626333627, 7874.251946065115, 7891.2897839194175, 7893.8026549336155, 4935.876603084916, 5033.345665063555, 5056.367954005749, 5195.9740201298755, 5245.973770131125, 1810.6378724255069, 1824.3705921457076, 1833.9449816505394, 1856.9535761605932, 1861.3950466098572, 23426.53146937052, 23511.29466116019, 23575.41061473477, 23621.645675314885, 23639.881800590887, 6284.371562843679, 6555.836104097436, 6593.769218077345, 6742.528023038439, 6785.694643740945, 15950.202489875459, 15981.360745570048, 16016.0, 16034.599135021484, 16062.518124456285, 7452.105747310249, 7716.614169291513, 7765.650545725343, 7768.262015108556, 7768.7669369918995, 7013.088298521262, 7043.647817609099, 7104.751333703399, 7172.0, 7184.892226616605, 5056.165732654144, 5182.378114626194, 5239.842804715865, 5269.578433725293, 5314.043472174968, 1358.483776165051, 1385.4665953607935, 1453.1644304524941, 1518.50648539223, 1520.2702702702766, 905.2893478619252, 914.264017465933, 916.7616419730919, 920.9125133112343, 935.6818681648273, 8149.633266503021, 8221.095679475253, 8233.632311616268, 8277.58612069394, 8321.417500774887, 973.153356579766, 1010.3533738407425, 1012.3217444312328, 1018.2312354172552, 1018.3889666200369, 4990.10178167926, 5334.333208348957, 5348.518633322942, 5505.532029777433, 5586.832395028156, 18537.81462185361, 19151.13819878109, 19467.51331216731, 19573.1192096356, 19759.50601234952, 19435.222591096197, 19458.70811937822, 19554.608907821763, 19560.706589401172, 19565.608687826163, 10490.16078713701, 10759.731006724895, 10887.564497420015, 10979.505922233358, 11037.337759734442, 7964.20357964199, 8139.766524562561, 8166.265036146775, 8173.427860049977, 8227.465214761021, 16430.424935127212, 16794.496165115066, 17049.232784524975, 17258.13709314504, 17310.82689173092, 17249.137543122542, 17394.91302543479, 17420.47738567845, 17870.106494674954, 17876.91061544684, 10214.387136771817, 10468.0, 10526.473676316, 10617.044465998097, 10624.787504250025, 12765.8085128725, 12903.806442903177, 12961.481540738265, 12975.156614820384, 12987.090903637032, 10480.895191047992, 10531.368117912949, 10621.415822129857, 10704.678859634223, 10863.511141998471, 10063.849042264226, 10183.796324073624, 10208.897911021091, 10267.94866025665, 10489.737756556147, 9349.345545812, 9405.811883762422, 9464.95267523658, 9469.526523673927, 9495.28785341116, 7277.781666550012, 7290.234525374972, 7363.300486453778, 7374.410047196104, 7446.367058800062, 7299.708011679473, 7382.187959324363, 7451.962740186264, 7484.850302994018, 7507.512011719221], "value": 6438.093295260037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.69081823860085, 506.40497415536737, 532.1698150884619, 539.4901817782195, 539.6303532080527, 6286.779962701306, 6303.495720342373, 6317.083408286863, 6326.873462530747, 6359.58662686925, 5982.0, 6044.15653225766, 6113.969430152854, 6162.352952939944, 6162.9831077872095, 4984.77568509418, 4989.2017277235645, 5027.421846487646, 5031.496850314958, 5084.618653600985, 5044.974775126119, 5054.772535235923, 5059.139946209135, 5061.54446099851, 5082.0, 5012.398512178525, 5118.718470484122, 5240.213967904807, 5260.184671375943, 5267.420583735786, 5116.872078198037, 5153.6907785532985, 5222.033923724123, 5237.292965449654, 5239.13554263546, 4857.951420485821, 4900.774806298426, 4910.21436570147, 4911.557959783637, 4919.385076865392, 6163.753449862, 6173.456635841039, 6197.411245931629, 6254.968725156391, 6258.24901011877, 6063.939360606381, 6095.293317871004, 6109.663968481732, 6110.419510146529, 6121.877562448726, 6669.466442684574, 6677.799666010027, 6709.429698475636, 6723.159605049369, 6739.258681545026, 5262.973685131588, 5281.815136470205, 5281.86795330116, 5325.227841962933, 5346.679199248058, 6954.4436445084275, 7040.929590704079, 7068.752593659197, 7080.362767350963, 7114.786556403316, 5522.779088836482, 5595.0, 5597.552195824324, 5598.944010559923, 5612.887742245214, 5601.067631667069, 5624.775008999676, 5637.351704553947, 5691.345495268097, 5710.743016564182, 5956.374580668968, 5983.401659834069, 6024.27708674953, 6038.426349496791, 6044.667543285073, 6580.63806490638, 6637.402633762985, 6674.332566743286, 6716.429103526158, 6719.563228390139, 1855.3135339924315, 1882.7458293130253, 1893.4225061356144, 1943.679292916681, 1988.0656091636909, 1429.2348949047916, 1430.306301443799, 1432.8567143285798, 1457.2859298943442, 1484.4952716076587, 5659.122835960433, 5681.659100453986, 5759.337676167211, 5778.017736984722, 5782.219400380979, 6532.771353002622, 6595.307492713292, 6688.765893193715, 6715.3620406061345, 6784.253732089466, 5677.574181936371, 5748.166515855178, 5753.913691294634, 5759.452851979056, 5775.047117225611, 3512.4028915084496, 3586.1751797086818, 3610.98194509031, 3624.7281453891064, 3632.328019316435, 6422.518311126684, 6525.282218955911, 6537.901931471032, 6573.868522629521, 6580.934190658128, 6754.615303862696, 6774.661266936633, 6844.555103918229, 6896.586204827626, 6988.720451181997, 6465.482761378984, 6465.903011454832, 6540.8364790880605, 6547.202622478951, 6588.967055164693, 6724.226713927961, 6732.899006515004, 6757.391834734897, 6757.831054223684, 6834.1457317835275, 6589.769358072444, 6734.427573656294, 6756.189257289157, 6783.796486105227, 6828.487863410165, 6648.867022659423, 6667.333266673294, 6678.699458524476, 6684.933150668431, 6708.429783468265, 5034.798608055637, 5047.4952504749235, 5059.645824792229, 5075.264086707333, 5079.212722028092, 6827.941669041306, 6852.657367131723, 6873.175218973755, 6879.793606191823, 6885.931140688529, 6325.841853953688, 6350.809475715736, 6416.679166041586, 6438.420542151229, 6535.705893234911, 6424.582402143846, 6453.548251622341, 6461.030845373231, 6517.73929042833, 6594.406503414716, 6325.525585581192, 6374.458171055512, 6386.425221730066, 6465.674536720056, 6517.674116294261, 6578.046183303299, 6578.440832529097, 6581.572197807127, 6609.405153536205, 6613.404793568602, 6411.493299074807, 6429.5499315049365, 6451.612903225821, 6495.675216239264, 6515.706793194223], "value": 5205.322104969748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.0762725833281, 929.2612373163334, 941.8257622339872, 942.7878727286361, 950.1306304731169, 18451.815481845177, 19213.99999999998, 19223.03884805761, 19261.03694815259, 21603.351899443, 18948.0, 19080.618387632272, 19091.0, 19147.712784308245, 19160.808391916078, 999.8850132234795, 1040.4225654761603, 1045.5869931377101, 1045.9581616735359, 1049.2130901823632, 1045.9581616735322, 1051.647698021164, 1052.4264275969576, 1053.010170439788, 1054.346305290717, 1017.8524114003465, 1104.6520346090995, 1106.4799544214206, 1108.451316598285, 1114.0140975236934, 1094.1192340166124, 1095.3263742798201, 1095.61105807438, 1101.0640955188105, 1101.5924108079982, 788.9447738658296, 791.4262159934059, 792.0218530115303, 792.4373694676786, 792.4848848248627, 20449.182032718672, 20479.590408191903, 20589.0, 20685.379438616867, 20781.5843683127, 21671.67492487614, 21859.0, 22312.442188945242, 22343.888280558494, 22548.774512254833, 16597.0, 16621.6675666486, 16711.247993840305, 16849.663006739796, 16860.578485537837, 3734.850605975758, 3754.793486358249, 3766.4162054881535, 3770.340190466685, 3770.472133901256, 123829.38085309605, 124705.37647311795, 124789.37605312007, 125396.37301813524, 126311.99999999908, 16968.406105786486, 17027.574310642085, 17246.482605521855, 17454.825451745575, 17595.73606395905, 30867.536986945215, 31045.223869402995, 31152.53271200934, 31417.214569635486, 31685.683143168273, 7795.922040779633, 8148.633311500997, 8183.918160818434, 8854.29165666745, 8961.731148065568, 4122.361034039729, 4414.404055452537, 4418.889527761768, 4426.601605855424, 4430.756308403069, 5285.947140528622, 5384.273123128328, 5402.162664786964, 5408.91886621701, 5410.648307859977, 1053.0, 1067.3062509368972, 1081.3457857995957, 1085.777415629794, 1085.9891401086047, 525.7397588193869, 554.9472800083986, 565.4684596479296, 569.4362581044736, 569.9116636921284, 10762.94618526918, 10965.287256328313, 11111.944440277746, 11769.470373833197, 11983.580574679845, 469.86608816487137, 481.662836014791, 539.9028174928472, 550.1664977559001, 550.499045868258, 4892.559669629751, 5076.162433198555, 5120.692758434506, 5255.684658920477, 5282.788688452419, 96085.5195724031, 98246.0, 98516.0, 98935.50532247292, 102926.0, 84017.57991210127, 85481.0, 85648.57175714082, 86439.0, 90399.54800225957, 76979.61510192526, 77674.2232577667, 78971.21028789754, 81073.18926810774, 82438.17561824305, 10442.112420444348, 10455.94772026135, 10610.469476526298, 10847.24069315172, 10894.78210435771, 35994.28011439809, 36732.44901326536, 37270.06824829401, 37331.52157622886, 37412.812935935144, 63018.684906575174, 65631.34368656443, 66680.96076270669, 66732.666336668, 70215.0, 16410.507684769476, 16477.83522164763, 16571.50285491437, 16680.082595456883, 17013.914930425268, 16210.189490525663, 17396.652066958337, 18663.346782862536, 19289.131989060246, 19881.105350259564, 16463.83536164671, 16898.577535561708, 16999.0, 17218.397356092475, 17361.218745156246, 16869.325226990783, 17042.573935651213, 17177.828221717624, 17215.913920430317, 17942.910285448488, 15770.448034318744, 16433.09617970975, 16640.83359166393, 16812.0, 17046.744298835278, 12553.497860085494, 12729.29988850622, 12926.224426534438, 13139.737205256033, 13663.863361366657, 11795.941020294844, 12618.810717839056, 12819.038572106943, 13093.869061309646, 13146.671333216364], "value": 8816.881229672423, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 108.0, 106.0, 110.0, 108.0, 108.0, 99.0, 111.0, 107.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 144.0, 188.0, 120.0, 146.0, 145.0, 118.0, 182.0, 123.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 163.0, 163.0, 166.0, 170.0, 165.0, 161.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 82.0, 168.0, 76.0, 73.0, 79.0, 82.0, 97.0, 77.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 139.0, 79.0, 78.0, 78.0, 130.0, 81.0, 84.0, 126.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 122.0, 116.0, 117.0, 115.0, 124.0, 114.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 150.0, 152.0, 151.0, 150.0, 150.0, 158.0, 150.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 57.0, 55.0, 56.0, 54.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 59.0, 54.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 83.0, 79.0, 98.0, 79.0, 79.0, 97.0, 87.0, 92.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 139.0, 128.0, 127.0, 128.0, 131.0, 125.0, 128.0, 132.0, 171.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 179.0, 177.0, 173.0, 178.0, 174.0, 170.0, 172.0, 171.0, 170.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 73.0, 64.0, 67.0, 65.0, 66.0, 66.0], "value": 66.5, "unit": "score"}]}]} 19:35:11 INFO - Return code: 0 19:35:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:35:11 INFO - # TBPL SUCCESS # 19:35:11 INFO - Running post-action listener: _package_coverage_data 19:35:11 INFO - Running post-action listener: _resource_record_post_action 19:35:11 INFO - [mozharness: 2017-08-07 02:35:11.968067Z] Finished run-tests step (success) 19:35:11 INFO - Running post-run listener: _resource_record_post_run 19:35:12 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 28672; Write bytes: 427421696; Read time: 616; Write time: 1089696 19:35:12 INFO - TinderboxPrint: CPU usage
13.3% 19:35:12 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 616 19:35:12 INFO - TinderboxPrint: I/O write bytes / time
427,421,696 / 1,089,696 19:35:12 INFO - TinderboxPrint: CPU idle
8,276.8 (86.7%) 19:35:12 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 19:35:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:35:12 INFO - install - Wall time: 18s; CPU: 16.0%; Read bytes: 4096; Write bytes: 106520576; Read time: 28; Write time: 375140 19:35:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:35:12 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 20480; Write bytes: 320901120; Read time: 580; Write time: 714556 19:35:12 INFO - Running post-run listener: _upload_blobber_files 19:35:12 INFO - Blob upload gear active. 19:35:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:35: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 19:35: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'] 19:35: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 19:35:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:13 INFO - (blobuploader) - INFO - Done attempting. 19:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:17 INFO - (blobuploader) - INFO - Done attempting. 19:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:17 INFO - (blobuploader) - INFO - Done attempting. 19:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:18 INFO - (blobuploader) - INFO - Done attempting. 19:35:18 INFO - (blobuploader) - INFO - Iteration through files over. 19:35:18 INFO - Return code: 0 19:35:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:35:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:35:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ff8aeb129f060f39a828791909d147d07d6684716afe8a4bc2ca90a80a9fc386ad86265e0a4ef53c40f58abea1b8cb95be5850c2cebbad561b4d5a257197382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4104ba61878f424f17ca9149a51b480aa688db7cfd75c4e38eeab260f5e5d271d23045898fde8c6635bd77b7967de218189cd67a91ffefb3864b268128d4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6943566e095255f80a1f2f26a8b04cee6c234875454b6bc8c399292a9a61a6d0fe9d59e77e65d8cecad432f2b68351e43e84f47f03c0e3502895f61bb6f9bb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52f3994e402b5ed54dc9b24412e7d1659c8b7e9f46822978f134a8ecb9bb93afb00ea732d0776e38f6edc7ab51d61a2ed623123e3e469f3789112e3937790b0"} 19:35:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:35:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:35:18 INFO - Contents: 19:35:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ff8aeb129f060f39a828791909d147d07d6684716afe8a4bc2ca90a80a9fc386ad86265e0a4ef53c40f58abea1b8cb95be5850c2cebbad561b4d5a257197382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4104ba61878f424f17ca9149a51b480aa688db7cfd75c4e38eeab260f5e5d271d23045898fde8c6635bd77b7967de218189cd67a91ffefb3864b268128d4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6943566e095255f80a1f2f26a8b04cee6c234875454b6bc8c399292a9a61a6d0fe9d59e77e65d8cecad432f2b68351e43e84f47f03c0e3502895f61bb6f9bb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52f3994e402b5ed54dc9b24412e7d1659c8b7e9f46822978f134a8ecb9bb93afb00ea732d0776e38f6edc7ab51d61a2ed623123e3e469f3789112e3937790b0"} 19:35:18 INFO - Running post-run listener: copy_logs_to_upload_dir 19:35:18 INFO - Copying logs to upload dir... 19:35:18 INFO - mkdir: /builds/slave/test/build/upload/logs 19:35:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.771848 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-08-06 19:35:18.696418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:35:18.703898) ========= 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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 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/1ff8aeb129f060f39a828791909d147d07d6684716afe8a4bc2ca90a80a9fc386ad86265e0a4ef53c40f58abea1b8cb95be5850c2cebbad561b4d5a257197382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4104ba61878f424f17ca9149a51b480aa688db7cfd75c4e38eeab260f5e5d271d23045898fde8c6635bd77b7967de218189cd67a91ffefb3864b268128d4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6943566e095255f80a1f2f26a8b04cee6c234875454b6bc8c399292a9a61a6d0fe9d59e77e65d8cecad432f2b68351e43e84f47f03c0e3502895f61bb6f9bb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52f3994e402b5ed54dc9b24412e7d1659c8b7e9f46822978f134a8ecb9bb93afb00ea732d0776e38f6edc7ab51d61a2ed623123e3e469f3789112e3937790b0"} build_url:https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ff8aeb129f060f39a828791909d147d07d6684716afe8a4bc2ca90a80a9fc386ad86265e0a4ef53c40f58abea1b8cb95be5850c2cebbad561b4d5a257197382", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4104ba61878f424f17ca9149a51b480aa688db7cfd75c4e38eeab260f5e5d271d23045898fde8c6635bd77b7967de218189cd67a91ffefb3864b268128d4a72", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc6943566e095255f80a1f2f26a8b04cee6c234875454b6bc8c399292a9a61a6d0fe9d59e77e65d8cecad432f2b68351e43e84f47f03c0e3502895f61bb6f9bb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52f3994e402b5ed54dc9b24412e7d1659c8b7e9f46822978f134a8ecb9bb93afb00ea732d0776e38f6edc7ab51d61a2ed623123e3e469f3789112e3937790b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:35:18.734019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:35:18.734354) ========= 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=8783db0840cc980e80bb0bd400000236-1502072039.288599-1965462870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:35:18.813303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:35:18.813640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:35:18.813934) ========= ========= Total master_lag: 0.20 =========