builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1502852716.72 results: success (0) revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.723913) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.724478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.724796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.769982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.770691) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 20:05:16-- 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% 46.4M=0s 2017-08-15 20:05:16 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.935701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.936049) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016226 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.987440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:16.987830) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6966f27380bf2e3e5ace3507f600852bd3ed9dbd --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 6966f27380bf2e3e5ace3507f600852bd3ed9dbd --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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 20:05:17,046 truncating revision to first 12 chars 2017-08-15 20:05:17,046 Setting DEBUG logging. 2017-08-15 20:05:17,046 attempt 1/10 2017-08-15 20:05:17,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6966f27380bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 20:05:17,480 unpacking tar archive at: mozilla-central-6966f27380bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:17.736462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:17.736809) ========= script_repo_revision: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:17.737429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:17.737732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:17.749895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-15 20:05:17.750234) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:17 INFO - MultiFileLogger online at 20170815 20:05:17 in /builds/slave/test 20:05:17 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 20:05:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:17 INFO - {'append_to_log': False, 20:05:17 INFO - 'base_work_dir': '/builds/slave/test', 20:05:17 INFO - 'blob_upload_branch': 'Firefox', 20:05:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:17 INFO - 'branch': 'Firefox', 20:05:17 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:17 INFO - 'code_coverage': False, 20:05:17 INFO - 'config_files': ('talos/linux_config.py',), 20:05:17 INFO - 'default_actions': ('clobber', 20:05:17 INFO - 'read-buildbot-config', 20:05:17 INFO - 'download-and-extract', 20:05:17 INFO - 'populate-webroot', 20:05:17 INFO - 'create-virtualenv', 20:05:17 INFO - 'install', 20:05:17 INFO - 'setup-mitmproxy', 20:05:17 INFO - 'run-tests'), 20:05:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:17 INFO - 'disable_ccov_upload': False, 20:05:17 INFO - 'download_minidump_stackwalk': True, 20:05:17 INFO - 'download_symbols': 'ondemand', 20:05:17 INFO - 'enable_stylo': False, 20:05:17 INFO - 'enable_webrender': False, 20:05:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:17 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:17 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:17 INFO - 'gecko_profile': False, 20:05:17 INFO - 'gecko_profile_interval': 0, 20:05:17 INFO - 'installer_path': 'installer.exe', 20:05:17 INFO - 'log_level': 'info', 20:05:17 INFO - 'log_name': 'talos', 20:05:17 INFO - 'log_to_console': True, 20:05:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:17 INFO - 'opt_config_files': (), 20:05:17 INFO - 'pip_index': False, 20:05:17 INFO - 'suite': 'dromaeojs-e10s', 20:05:17 INFO - 'system_bits': '32', 20:05:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:17 INFO - 'title': 'talos-linux64-ix-064', 20:05:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:17 INFO - 'use_talos_json': True, 20:05:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:17 INFO - 'work_dir': 'build'} 20:05:17 INFO - [mozharness: 2017-08-16 03:05:17.989687Z] Running clobber step. 20:05:17 INFO - Running pre-action listener: _resource_record_pre_action 20:05:17 INFO - Running main action method: clobber 20:05:17 INFO - rmtree: /builds/slave/test/build 20:05:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:18 INFO - Running post-action listener: _resource_record_post_action 20:05:18 INFO - [mozharness: 2017-08-16 03:05:18.972266Z] Finished clobber step (success) 20:05:18 INFO - [mozharness: 2017-08-16 03:05:18.972367Z] Running read-buildbot-config step. 20:05:18 INFO - Running pre-action listener: _resource_record_pre_action 20:05:18 INFO - Running main action method: read_buildbot_config 20:05:18 INFO - Using buildbot properties: 20:05:18 INFO - { 20:05:18 INFO - "project": "", 20:05:18 INFO - "product": "firefox", 20:05:18 INFO - "who": "kwierso@gmail.com", 20:05:18 INFO - "installer_path": "public/build/target.tar.bz2", 20:05:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:05:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:05:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 20:05:18 INFO - "stage_platform": "linux64-pgo", 20:05:18 INFO - "basedir": "/builds/slave/test", 20:05:18 INFO - "buildnumber": 120, 20:05:18 INFO - "platform": "ubuntu64_hw", 20:05:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:05:18 INFO - "slavebuilddir": "test", 20:05:18 INFO - "taskId": "BzXXHH-dRhaBeyy-5aAfBQ", 20:05:18 INFO - "branch": "mozilla-central", 20:05:18 INFO - "script_repo_revision": "production", 20:05:18 INFO - "revision": "6966f27380bf2e3e5ace3507f600852bd3ed9dbd", 20:05:18 INFO - "slavename": "talos-linux64-ix-064", 20:05:18 INFO - "repo_path": "mozilla-central" 20:05:18 INFO - } 20:05:18 INFO - Finding installer, test and symbols from parent task. 20:05:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BzXXHH-dRhaBeyy-5aAfBQ'}, attempt #1 20:05:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BzXXHH-dRhaBeyy-5aAfBQ'}, attempt #1 20:05:19 INFO - Task dependencies: Grvz1iDjQMWMGsNN5J8IWw 20:05:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw'}, attempt #1 20:05:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 20:05:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.test_packages.json 20:05:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.crashreporter-symbols.zip 20:05:20 INFO - Running post-action listener: _resource_record_post_action 20:05:20 INFO - [mozharness: 2017-08-16 03:05:20.369849Z] Finished read-buildbot-config step (success) 20:05:20 INFO - [mozharness: 2017-08-16 03:05:20.370071Z] Running download-and-extract step. 20:05:20 INFO - Running pre-action listener: _resource_record_pre_action 20:05:20 INFO - Running main action method: download_and_extract 20:05:20 INFO - mkdir: /builds/slave/test/build/tests 20:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:20 INFO - trying https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.test_packages.json 20:05:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:05:20 INFO - Downloaded 989 bytes. 20:05:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:05:20 INFO - Using the following test package requirements: 20:05:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:05:20 INFO - u'common': [u'target.common.tests.zip'], 20:05:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:05:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:05:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:05:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:05:20 INFO - u'mozbase': [u'target.common.tests.zip'], 20:05:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:05:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:05:20 INFO - u'web-platform': [u'target.common.tests.zip', 20:05:20 INFO - u'target.web-platform.tests.tar.gz'], 20:05:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:05:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:05:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip 20:05:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip into memory 20:05:23 INFO - Content-Length response header: 54614525 20:05:23 INFO - Bytes received: 54614525 20:05:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:05:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip 20:05:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.common.tests.zip into memory 20:05:35 INFO - Content-Length response header: 54614525 20:05:35 INFO - Bytes received: 54614525 20:05:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.talos.tests.zip 20:05:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:05:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.talos.tests.zip into memory 20:05:49 INFO - Content-Length response header: 14496050 20:05:49 INFO - Bytes received: 14496050 20:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:49 INFO - trying https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 20:05:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:05:52 INFO - Downloaded 62826562 bytes. 20:05:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 20:05:52 INFO - mkdir: /builds/slave/test/properties 20:05:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:52 INFO - Contents: 20:05:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 20:05:52 INFO - Running post-action listener: _resource_record_post_action 20:05:52 INFO - Running post-action listener: set_extra_try_arguments 20:05:52 INFO - [mozharness: 2017-08-16 03:05:52.493393Z] Finished download-and-extract step (success) 20:05:52 INFO - [mozharness: 2017-08-16 03:05:52.493624Z] Running populate-webroot step. 20:05:52 INFO - Running pre-action listener: _resource_record_pre_action 20:05:52 INFO - Running main action method: populate_webroot 20:05:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:05:52 INFO - 'tests': ['damp', 'tps']}, 20:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:05:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:05:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:52 INFO - 'ts_paint', 20:05:52 INFO - 'tpaint', 20:05:52 INFO - 'sessionrestore', 20:05:52 INFO - 'sessionrestore_many_windows', 20:05:52 INFO - 'sessionrestore_no_auto_restore', 20:05:52 INFO - 'tabpaint']}, 20:05:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:05:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:52 INFO - 'tsvgr_opacity', 20:05:52 INFO - 'tart', 20:05:52 INFO - 'tscrollx', 20:05:52 INFO - 'tsvg_static']}, 20:05:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:05:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:05:52 INFO - 'talos_options': ['--mitmproxy', 20:05:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:05:52 INFO - '--firstNonBlankPaint'], 20:05:52 INFO - 'tests': ['tp6_google', 20:05:52 INFO - 'tp6_youtube', 20:05:52 INFO - 'tp6_amazon', 20:05:52 INFO - 'tp6_facebook']}, 20:05:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:05:52 INFO - 'talos_options': ['--stylo', 20:05:52 INFO - '--mitmproxy', 20:05:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:05:52 INFO - '--firstNonBlankPaint'], 20:05:52 INFO - 'tests': ['tp6_google', 20:05:52 INFO - 'tp6_youtube', 20:05:52 INFO - 'tp6_amazon', 20:05:52 INFO - 'tp6_facebook']}, 20:05:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:05:52 INFO - 'talos_options': ['--stylo', 20:05:52 INFO - '--stylo-threads=1', 20:05:52 INFO - '--mitmproxy', 20:05:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:05:52 INFO - '--firstNonBlankPaint'], 20:05:52 INFO - 'tests': ['tp6_google', 20:05:52 INFO - 'tp6_youtube', 20:05:52 INFO - 'tp6_amazon', 20:05:52 INFO - 'tp6_facebook']}, 20:05:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:05:52 INFO - 'talos_options': ['--xperf_path', 20:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:52 INFO - 'tests': ['tp5n']}}} 20:05:52 INFO - Running post-action listener: _resource_record_post_action 20:05:52 INFO - [mozharness: 2017-08-16 03:05:52.504296Z] Finished populate-webroot step (success) 20:05:52 INFO - [mozharness: 2017-08-16 03:05:52.504386Z] Running create-virtualenv step. 20:05:52 INFO - Running pre-action listener: _resource_record_pre_action 20:05:52 INFO - Running main action method: create_virtualenv 20:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:52 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 20:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:52 INFO - Using real prefix '/usr' 20:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:55 INFO - Installing pip.................done. 20:05:55 INFO - Return code: 0 20:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:05:55 INFO - Reading from file tmpfile_stdout 20:05:55 INFO - Output received: 20:05:55 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) 20:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:55 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:05:55 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 20:05:55 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 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 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 20:05:55 INFO - Cleaning up... 20:05:55 INFO - Return code: 0 20:05:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:55 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:05:55 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 20:05:55 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 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 INFO - Downloading/unpacking psutil>=3.1.1 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:57 INFO - Installing collected packages: psutil 20:05:57 INFO - Running setup.py install for psutil 20:05:57 INFO - building 'psutil._psutil_linux' extension 20:05:57 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 20:05: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 20:05:58 INFO - building 'psutil._psutil_posix' extension 20:05: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 20:05: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:58 INFO - Successfully installed psutil 20:05:58 INFO - Cleaning up... 20:05:58 INFO - Return code: 0 20:05:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:58 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:05:58 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 20:05:58 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 20:05:58 INFO - Using env: {'DISPLAY': ':0', 20:05:58 INFO - 'HOME': '/home/cltbld', 20:05:58 INFO - 'LANG': 'en_US.UTF-8', 20:05:58 INFO - 'LANGUAGE': 'en_US:en', 20:05:58 INFO - 'LOGNAME': 'cltbld', 20:05:58 INFO - 'MAIL': '/var/mail/cltbld', 20:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:58 INFO - 'MOZ_NO_REMOTE': '1', 20:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:58 INFO - 'NO_EM_RESTART': '1', 20:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:58 INFO - 'PWD': '/builds/slave/test', 20:05:58 INFO - 'SHELL': '/bin/bash', 20:05:58 INFO - 'SHLVL': '1', 20:05:58 INFO - 'TERM': 'linux', 20:05:58 INFO - 'TMOUT': '86400', 20:05:58 INFO - 'USER': 'cltbld', 20:05:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:58 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:00 INFO - Installing collected packages: mozsystemmonitor 20:06:00 INFO - Running setup.py install for mozsystemmonitor 20:06:00 INFO - Successfully installed mozsystemmonitor 20:06:00 INFO - Cleaning up... 20:06:00 INFO - Return code: 0 20:06:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06: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')]} 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06: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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06: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 20:06: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 20:06:00 INFO - Using env: {'DISPLAY': ':0', 20:06:00 INFO - 'HOME': '/home/cltbld', 20:06:00 INFO - 'LANG': 'en_US.UTF-8', 20:06:00 INFO - 'LANGUAGE': 'en_US:en', 20:06:00 INFO - 'LOGNAME': 'cltbld', 20:06:00 INFO - 'MAIL': '/var/mail/cltbld', 20:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:00 INFO - 'MOZ_NO_REMOTE': '1', 20:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:00 INFO - 'NO_EM_RESTART': '1', 20:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:00 INFO - 'PWD': '/builds/slave/test', 20:06:00 INFO - 'SHELL': '/bin/bash', 20:06:00 INFO - 'SHLVL': '1', 20:06:00 INFO - 'TERM': 'linux', 20:06:00 INFO - 'TMOUT': '86400', 20:06:00 INFO - 'USER': 'cltbld', 20:06:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:00 INFO - '_': '/tools/buildbot/bin/python'} 20:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:06: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 20:06: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 20:06: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 20:06: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 20:06:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:01 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:01 INFO - warning: no files found matching '*.txt' 20:06:01 INFO - no previously-included directories found matching 'build' 20:06:01 INFO - no previously-included directories found matching 'dist' 20:06:01 INFO - no previously-included directories found matching '.git*' 20:06:01 INFO - Installing collected packages: jsonschema, functools32 20:06:01 INFO - Running setup.py install for functools32 20:06:01 INFO - warning: no files found matching '*.txt' 20:06:01 INFO - no previously-included directories found matching 'build' 20:06:01 INFO - no previously-included directories found matching 'dist' 20:06:01 INFO - no previously-included directories found matching '.git*' 20:06:01 INFO - Successfully installed jsonschema functools32 20:06:01 INFO - Cleaning up... 20:06:01 INFO - Return code: 0 20:06:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:06:01 INFO - Using env: {'DISPLAY': ':0', 20:06:01 INFO - 'HOME': '/home/cltbld', 20:06:01 INFO - 'LANG': 'en_US.UTF-8', 20:06:01 INFO - 'LANGUAGE': 'en_US:en', 20:06:01 INFO - 'LOGNAME': 'cltbld', 20:06:01 INFO - 'MAIL': '/var/mail/cltbld', 20:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:01 INFO - 'MOZ_NO_REMOTE': '1', 20:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:01 INFO - 'NO_EM_RESTART': '1', 20:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:01 INFO - 'PWD': '/builds/slave/test', 20:06:01 INFO - 'SHELL': '/bin/bash', 20:06:01 INFO - 'SHLVL': '1', 20:06:01 INFO - 'TERM': 'linux', 20:06:01 INFO - 'TMOUT': '86400', 20:06:01 INFO - 'USER': 'cltbld', 20:06:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:01 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06: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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06: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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06: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 20:06: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 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:06: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 20:06: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 20:06: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 20:06: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 20:06:03 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06:03 INFO - Downloading docopt-0.6.1.tar.gz 20:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:04 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:04 INFO - Running setup.py install for blobuploader 20:06:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:04 INFO - Running setup.py install for requests 20:06:04 INFO - Running setup.py install for docopt 20:06:04 INFO - Successfully installed blobuploader requests docopt 20:06:04 INFO - Cleaning up... 20:06:04 INFO - Return code: 0 20:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:04 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')]} 20:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:04 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')]} 20:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:04 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06:04 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 20:06:04 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 20:06:04 INFO - Using env: {'DISPLAY': ':0', 20:06:04 INFO - 'HOME': '/home/cltbld', 20:06:04 INFO - 'LANG': 'en_US.UTF-8', 20:06:04 INFO - 'LANGUAGE': 'en_US:en', 20:06:04 INFO - 'LOGNAME': 'cltbld', 20:06:04 INFO - 'MAIL': '/var/mail/cltbld', 20:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:04 INFO - 'MOZ_NO_REMOTE': '1', 20:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:04 INFO - 'NO_EM_RESTART': '1', 20:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:04 INFO - 'PWD': '/builds/slave/test', 20:06:04 INFO - 'SHELL': '/bin/bash', 20:06:04 INFO - 'SHLVL': '1', 20:06:04 INFO - 'TERM': 'linux', 20:06:04 INFO - 'TMOUT': '86400', 20:06:04 INFO - 'USER': 'cltbld', 20:06:04 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:04 INFO - '_': '/tools/buildbot/bin/python'} 20:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:04 INFO - Running setup.py (path:/tmp/pip-zqXnpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:04 INFO - Running setup.py (path:/tmp/pip-2P6A_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:05 INFO - Running setup.py (path:/tmp/pip-TW2ScG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:05 INFO - Running setup.py (path:/tmp/pip-GGKheD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:05 INFO - Running setup.py (path:/tmp/pip-JrJxmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:05 INFO - Running setup.py (path:/tmp/pip-Gp4Qyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:05 INFO - Running setup.py (path:/tmp/pip-i2fcia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:05 INFO - Running setup.py (path:/tmp/pip-AJR3iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:05 INFO - Running setup.py (path:/tmp/pip-ShjEtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:05 INFO - Running setup.py (path:/tmp/pip-EGwah3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:05 INFO - Running setup.py (path:/tmp/pip-MjZMtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:05 INFO - Running setup.py (path:/tmp/pip-Fy6Jto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:05 INFO - Running setup.py (path:/tmp/pip-HrXTmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:05 INFO - Running setup.py (path:/tmp/pip-aupo0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:05 INFO - Running setup.py (path:/tmp/pip-ijIPpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:05 INFO - Running setup.py (path:/tmp/pip-clDZxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:06 INFO - Running setup.py (path:/tmp/pip-xwSuDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:06 INFO - Running setup.py install for manifestparser 20:06:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozcrash 20:06:06 INFO - Running setup.py install for mozdebug 20:06:06 INFO - Running setup.py install for mozdevice 20:06:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozfile 20:06:06 INFO - Running setup.py install for mozhttpd 20:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozinfo 20:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozInstall 20:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozleak 20:06:06 INFO - Running setup.py install for mozlog 20:06:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for moznetwork 20:06:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozprocess 20:06:07 INFO - Running setup.py install for mozprofile 20:06:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozrunner 20:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozscreenshot 20:06:07 INFO - Running setup.py install for moztest 20:06:07 INFO - Running setup.py install for mozversion 20:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:07 INFO - Cleaning up... 20:06:07 INFO - Return code: 0 20:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:07 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')]} 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:07 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')]} 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:07 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06:07 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 20:06:07 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 20:06:07 INFO - Using env: {'DISPLAY': ':0', 20:06:07 INFO - 'HOME': '/home/cltbld', 20:06:07 INFO - 'LANG': 'en_US.UTF-8', 20:06:07 INFO - 'LANGUAGE': 'en_US:en', 20:06:07 INFO - 'LOGNAME': 'cltbld', 20:06:07 INFO - 'MAIL': '/var/mail/cltbld', 20:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:07 INFO - 'MOZ_NO_REMOTE': '1', 20:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:07 INFO - 'NO_EM_RESTART': '1', 20:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:07 INFO - 'PWD': '/builds/slave/test', 20:06:07 INFO - 'SHELL': '/bin/bash', 20:06:07 INFO - 'SHLVL': '1', 20:06:07 INFO - 'TERM': 'linux', 20:06:07 INFO - 'TMOUT': '86400', 20:06:07 INFO - 'USER': 'cltbld', 20:06:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:07 INFO - '_': '/tools/buildbot/bin/python'} 20:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:08 INFO - Running setup.py (path:/tmp/pip-S24hlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:08 INFO - Running setup.py (path:/tmp/pip-VOQhge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:08 INFO - Running setup.py (path:/tmp/pip-uuTW_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:08 INFO - Running setup.py (path:/tmp/pip-K0Ju4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:08 INFO - Running setup.py (path:/tmp/pip-QyLAqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:08 INFO - Running setup.py (path:/tmp/pip-hYWhfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06: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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:08 INFO - Running setup.py (path:/tmp/pip-R6o3t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:08 INFO - Running setup.py (path:/tmp/pip-p54ap0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:08 INFO - Running setup.py (path:/tmp/pip-jxXYJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:08 INFO - Running setup.py (path:/tmp/pip-M3ukHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:08 INFO - Running setup.py (path:/tmp/pip-c56Fo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:08 INFO - Running setup.py (path:/tmp/pip-sFCku_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:08 INFO - Running setup.py (path:/tmp/pip-H6CBTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06: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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:09 INFO - Running setup.py (path:/tmp/pip-1vtlE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06: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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:09 INFO - Running setup.py (path:/tmp/pip-3YlSOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06: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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:09 INFO - Running setup.py (path:/tmp/pip-MERpHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06: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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:09 INFO - Running setup.py (path:/tmp/pip-TmV0Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06: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 20:06: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 20:06: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 20:06: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 20:06:10 INFO - Downloading blessings-1.6.tar.gz 20:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:10 INFO - Installing collected packages: blessings 20:06:10 INFO - Running setup.py install for blessings 20:06:10 INFO - Successfully installed blessings 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:10 INFO - Reading from file tmpfile_stdout 20:06:10 INFO - Current package versions: 20:06:10 INFO - argparse == 1.2.1 20:06:10 INFO - blessings == 1.6 20:06:10 INFO - blobuploader == 1.2.4 20:06:10 INFO - docopt == 0.6.1 20:06:10 INFO - functools32 == 3.2.3-2 20:06:10 INFO - jsonschema == 2.5.1 20:06:10 INFO - manifestparser == 1.1 20:06:10 INFO - mozInstall == 1.13 20:06:10 INFO - mozcrash == 1.0 20:06:10 INFO - mozdebug == 0.1 20:06:10 INFO - mozdevice == 0.51 20:06:10 INFO - mozfile == 1.2 20:06:10 INFO - mozhttpd == 0.7 20:06:10 INFO - mozinfo == 0.10 20:06:10 INFO - mozleak == 0.1 20:06:10 INFO - mozlog == 3.5 20:06:10 INFO - moznetwork == 0.27 20:06:10 INFO - mozprocess == 0.25 20:06:10 INFO - mozprofile == 0.28 20:06:10 INFO - mozrunner == 6.13 20:06:10 INFO - mozscreenshot == 0.1 20:06:10 INFO - mozsystemmonitor == 0.3 20:06:10 INFO - moztest == 0.8 20:06:10 INFO - mozversion == 1.4 20:06:10 INFO - psutil == 3.1.1 20:06:10 INFO - requests == 1.2.3 20:06:10 INFO - wsgiref == 0.1.2 20:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06:10 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 20:06:10 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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:06: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 20:06: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 20:06: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 20:06: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 20:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:06: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)) 20:06: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)) 20:06:12 INFO - Installing collected packages: simplejson 20:06:12 INFO - Running setup.py install for simplejson 20:06:12 INFO - building 'simplejson._speedups' extension 20:06: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 20:06: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 20:06:13 INFO - Successfully installed simplejson 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06: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')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06: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 0xabe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd65ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', '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 20:06: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 20:06: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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Running post-action listener: _resource_record_post_action 20:06:13 INFO - Running post-action listener: _start_resource_monitoring 20:06:13 INFO - Starting resource monitoring. 20:06:13 INFO - [mozharness: 2017-08-16 03:06:13.662163Z] Finished create-virtualenv step (success) 20:06:13 INFO - [mozharness: 2017-08-16 03:06:13.662670Z] Running install step. 20:06:13 INFO - Running pre-action listener: _resource_record_pre_action 20:06:13 INFO - Running main action method: install 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:14 INFO - Reading from file tmpfile_stdout 20:06:14 INFO - Output received: 20:06:14 INFO - Usage: mozinstall [options] installer 20:06:14 INFO - Options: 20:06:14 INFO - -h, --help show this help message and exit 20:06:14 INFO - -d DEST, --destination=DEST 20:06:14 INFO - Directory to install application into. [default: 20:06:14 INFO - "/builds/slave/test"] 20:06:14 INFO - --app=APP Application being installed. [default: firefox] 20:06:14 INFO - mkdir: /builds/slave/test/build/application 20:06: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'] 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:06:31 INFO - Reading from file tmpfile_stdout 20:06:31 INFO - Output received: 20:06:31 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:31 INFO - Running post-action listener: _resource_record_post_action 20:06:31 INFO - [mozharness: 2017-08-16 03:06:31.759471Z] Finished install step (success) 20:06:31 INFO - [mozharness: 2017-08-16 03:06:31.759696Z] Running setup-mitmproxy step. 20:06:31 INFO - Running pre-action listener: _resource_record_pre_action 20:06:31 INFO - Running main action method: setup_mitmproxy 20:06:31 INFO - Skipping: mitmproxy is not required 20:06:31 INFO - Running post-action listener: _resource_record_post_action 20:06:31 INFO - [mozharness: 2017-08-16 03:06:31.760224Z] Finished setup-mitmproxy step (success) 20:06:31 INFO - [mozharness: 2017-08-16 03:06:31.760334Z] Running run-tests step. 20:06:31 INFO - Running pre-action listener: _resource_record_pre_action 20:06:31 INFO - Running pre-action listener: _set_gcov_prefix 20:06:31 INFO - Running main action method: run_tests 20:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:31 INFO - Python 2.7.3 20:06:31 INFO - Return code: 0 20:06:31 INFO - grabbing minidump binary from tooltool 20:06:31 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')]} 20:06:31 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 0xd630b0>, '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 0xd63fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd64440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:31 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 20:06:31 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 20:06:31 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 20:06:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:31 INFO - Return code: 0 20:06:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:31 INFO - ENV: RUST_BACKTRACE is now full 20:06:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:31 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/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:06:31 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/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 20:06:31 INFO - Using env: {'DISPLAY': ':0', 20:06:31 INFO - 'HOME': '/home/cltbld', 20:06:31 INFO - 'LANG': 'en_US.UTF-8', 20:06:31 INFO - 'LANGUAGE': 'en_US:en', 20:06:31 INFO - 'LOGNAME': 'cltbld', 20:06:31 INFO - 'MAIL': '/var/mail/cltbld', 20:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:31 INFO - 'MOZ_NO_REMOTE': '1', 20:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:31 INFO - 'NO_EM_RESTART': '1', 20:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:31 INFO - 'PWD': '/builds/slave/test', 20:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:31 INFO - 'RUST_BACKTRACE': 'full', 20:06:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:06:31 INFO - 'SHELL': '/bin/bash', 20:06:31 INFO - 'SHLVL': '1', 20:06:31 INFO - 'TERM': 'linux', 20:06:31 INFO - 'TMOUT': '86400', 20:06:31 INFO - 'USER': 'cltbld', 20:06:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739', 20:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:31 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 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/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:06:32 INFO - mozversion application_buildid: 20170816015150 20:06:32 INFO - mozversion application_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 20:06:32 INFO - mozversion application_display_name: Nightly 20:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:32 INFO - mozversion application_name: Firefox 20:06:32 INFO - mozversion application_remotingname: firefox 20:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:06:32 INFO - mozversion application_vendor: Mozilla 20:06:32 INFO - mozversion application_version: 57.0a1 20:06:32 INFO - mozversion platform_buildid: 20170816015150 20:06:32 INFO - mozversion platform_changeset: 6966f27380bf2e3e5ace3507f600852bd3ed9dbd 20:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:06:32 INFO - mozversion platform_version: 57.0a1 20:06:32 INFO - using testdate: 1502852792 20:06:32 INFO - actual date: 1502852792 20:06:32 INFO - starting webserver on 'localhost:51800' 20:06:32 INFO - SUITE-START | Running 2 tests 20:06:32 INFO - TEST-START | dromaeo_css 20:06:32 INFO - Initialising browser for dromaeo_css test... 20:06:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51800/getInfo.html -profile /tmp/tmpwwD3kY/profile 20:06:32 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox http://localhost:51800/getInfo.html) 20:06:40 INFO - TEST-INFO | 3330: exit 0 20:06:40 INFO - Browser initialized. 20:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:40 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwD3kY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:41 INFO - PID 3545 | 20:06:41 INFO - PID 3545 | (/builds/slave/test/build/application/firefox/firefox:3593): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:06:41 INFO - PID 3545 | 20:06:52 INFO - PID 3545 | RSS: Main: 158175232 20:06:52 INFO - PID 3545 | 20:09:49 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51800/tests/dromaeo/cssquery-ext.html) 20:09:51 INFO - PID 3545 | RSS: Main: 166703104 20:09:51 INFO - PID 3545 | 20:12:52 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-ext.html (next: http://localhost:51800/tests/dromaeo/cssquery-jquery.html) 20:12:53 INFO - PID 3545 | RSS: Main: 163627008 20:12:53 INFO - PID 3545 | 20:15:54 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51800/tests/dromaeo/cssquery-mootools.html) 20:15:55 INFO - PID 3545 | RSS: Main: 165498880 20:15:55 INFO - PID 3545 | 20:18:56 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51800/tests/dromaeo/cssquery-prototype.html) 20:18:57 INFO - PID 3545 | RSS: Main: 164175872 20:18:57 INFO - PID 3545 | 20:22:00 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51800/tests/dromaeo/cssquery-yui.html) 20:22:01 INFO - PID 3545 | RSS: Main: 167493632 20:22:01 INFO - PID 3545 | 20:25:02 INFO - PID 3545 | Cycle 1(1): loaded http://localhost:51800/tests/dromaeo/cssquery-yui.html (next: http://localhost:51800/tests/dromaeo/cssquery-dojo.html) 20:25:03 INFO - PID 3545 | RSS: Main: 167882752 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | __start_tp_report 20:25:03 INFO - PID 3545 | _x_x_mozilla_page_load 20:25:03 INFO - PID 3545 | _x_x_mozilla_page_load_details 20:25:03 INFO - PID 3545 | |i|pagename|runs| 20:25:03 INFO - PID 3545 | |0;dojo.html;3454.8445319960615;3507.3686736387453;3510.403231450653;3512.5082488451635;3528.841202145903;6083.026715725479;6128.417800308975;6141.72362243699;6164.845878853025;6168.290646575645;6066.423689749467;6183.814485565429;6196.008638617822;6196.72114754836;6215.223097112861;5420.512153906147;5447.400785913546;5474.808381706641;5477.315335583052;5506.284183056197;5352.464753524655;5395.460453954613;5476.3702174249875;5478.58910581706;5554.250176226218;5413.756380962846;5436.619436639437;5526.447355264441;5526.557875369961;5541.307336582927;5463.235147079412;5485.588580856452;5511.173324001432;5546.417626149277;5546.69493177875;5338.145896656555;5433.945660543383;5480.177973303997;5480.3971563128025;5526.806561770319;6133.601315914496;6135.9079613805825;6191.318954914956;6231.40801623845;6259.843503912393;6795.898061529081;6813.4208592269715;6818.829529261759;6819.386255237053;6829.385355318045;6793.796186114425;6800.149981252343;6824.21521525021;6877.2091209511045;6890.44876409886;6169.7840575580085;6252.124702541648;6329.335419780903;6391.2330520337855;6401.935980640227;6866.244713081557;6909.930900690929;6920;6923.2038315594355;7043;6496.317886621931;6559.278479367265;6750.392464678104;6765.729370825112;6766.661666916634;6752.22349429812;6756.391924726799;6763;6768.830779230559;6802.01370801231;6686.431653309426;6810.250872404032;6816.761413350609;6817.863642727118;6832.59004459734;6772.458203343721;6790.083338749206;6827.897581536281;6836.38472537474;6854.828629284308;4800.1119792838435;4910.8772280693265;4932.8520144395725;4952.727599982036;4967.105920934194;4339.088791353851;4367.956320436755;4388.956110438919;4418.756968366771;4451.910961780746;6436.16329877113;6492.123563318892;6496.123023391876;6502.154719886479;6503.122078519339;6806.591604503746;6808.62552559614;6812.318768123148;6891.793246202622;6895.55178913369;6393.264774550986;6433.967830160819;6491.383318584727;6507.12153859223;6514.837129071811;5490.368607610176;5514.255575497336;5529.612927095065;5531.197976293495;5533.363663178786;7100.92899071013;7108.182559005677;7166.820829479409;7179.676914538858;7187.245339239409;6663.900041499284;6739.6967136478;6746.831329216612;6756.054152418764;6762.459003279824;7134.750283740044;7176.892346614909;7198.460115491254;7203.279672032964;7205.3515183631625;6629.569078010107;6689;6715.832104197239;6769.830754231184;6774.86450270982;6729.0915726376315;6815.761448349284;6818.454523637998;6825.249222585611;6902.8619427612175;6571.638559879252;6580.670966451563;6631.6684165792485;6641.867162656623;6649.63427011519;6614.173228346457;6657.3342665733035;6685.498587605852;6692.196936367667;6696.430803381572;6469.547131700736;6573.211214654081;6581.835454113494;6657.467402607683;6673.766418175341;6525.3800888915475;6572.967135164294;6596.0435736816935;6631.767888123893;6650.068990341259;6498.122753428227;6517.4460170886005;6526.706298216497;6532.248791388861;6541.476681865344 20:25:03 INFO - PID 3545 | |1;ext.html;888.8800410099191;901.1079031758561;935.1303287942213;945.7068308824265;951.7810903492201;40345.79827100864;42294.788526057324;42321.78839105804;42360.15279694404;42409.99999999996;39163.608363916355;39314.41028384576;39426.80286598563;39525.209495810064;39536.802315988454;6924.9307506924915;7020.3681668649815;7024.754133605325;7025.297470252985;7031.753888613899;6892.655367231643;7027.9297207027785;7028.367446929801;7028.824279393005;7032.437405007613;7590.089189297292;7688.077430708323;7735.690572377098;7766;7768;7597.658105385271;7658.425618078639;7731.613419329039;7732.381409487284;7738.380929525624;7403.777886663409;7607.695692172307;7609.7336593219525;7610.657520411595;7615.124260710034;39535.20929581421;39958;40003.59996400028;40034.59965400338;40047;3466.4280393735257;3517.296540691872;3518.7185025197923;3519.577650681909;3521.454174602941;31269.061928142193;31283;31292.843535782402;31311.217219569466;31326;5050.469700681412;5073.365829271341;5091.61812864033;5105.310783044279;5128.589712822965;202071;202796;206644;209725;219484.9999999984;52613.47386526086;53288;53295.467045329824;53366.73316633392;53459.19811202835;55330;55336;55371.723141384035;55548.722256389265;55596.444035559936;16487;16600.08699521538;16619.91690041542;16707;16709.749353759704;13299.933500332436;13312.46750129984;13320.733585328433;13322.333883305795;13480.797788033187;15022.09867407959;15040.548783536511;15110.168940708147;15124.697506049817;15283.541493755205;5696.174054762119;5808.854778630483;5873.177755114288;5884.823455296348;6006.5495087868585;1047.61238341814;1058.227493929436;1077.3966578715945;1085.478970094359;1092.814221582317;24797.25608231756;24894.502109958063;24950.875245623654;25014.749852501605;25051.373715657253;1146.8451759012594;1188.744419949715;1190.7082764722525;1193.3591311946075;1196.246364790194;13172.209667419986;13191.934040329928;13254.602361929157;13338.599842004756;17235.65528689444;265717;267512;267630;268180;270177;60576;60747.392526074174;60774;60856.391436085956;61158.694206528686;1417.1426287096158;1446.4937271954732;1485.8514148585054;1488.1815001748994;1488.970220595582;29057.564136537545;29726.405471890874;29924.70075299219;30374;30545.847270763505;40454;40645;40676.59323406847;40743.59256407398;40774.999999998814;224091;224602;225430;225552;225624;35484;38606.80696596499;39564.80217598894;39587;39610.80194599008;47668.284975726085;48518;48773;48854.26718599295;48884.26673599828;35518.822405887804;36662.26675466529;36797.63202367942;36980.81509592435;37102.628973709914;36063.63936360603;36625.63374366329;36707.44938825866;37048.43424007528;37178.81410593038;40717.796411017756;42301.153976920905;42309.1538169241;42458.363124553776;42565.148697025266;34949.30101397907;35045.824770877;35294.64705353016;35455;35551.644483555865;26089.217323480327;26514.734852651225;26620.60069099004;27265.86367068152;27407.17778466649 20:25:03 INFO - PID 3545 | |2;jquery.html;562.6708375600274;571.5456212311212;576.7772322675925;581.813819577735;587.1075964533909;22714.659280110813;23147.30558083256;23573.528529429444;23576;23603.645945310793;25510.617340739904;27148;27160.32099197521;27228.727712722917;27321.86339068307;6323.683815809202;6438.002109673008;6447.419732224099;6460.547761656686;6467;6077.969610151965;6288.842778930541;6305.558610897239;6318.684065796715;6353.682315884211;6279.089532017854;6284.277308109557;6284.71718772654;6289.371062893697;6305.9369406305805;6306.432421082101;6308.779192728255;6308.968455157741;6314.557980941336;6316.368363163693;5856.355800861902;5868.09044598088;5869.325027621793;5871.295444546682;5885.529157667376;29209.269768255752;29697.406051878843;30165.69834301651;30487.847560762053;30758.53862192069;2256.0862850545554;2291.862488250694;2292.4383526036227;2292.988535057314;2293.9655905161435;20146.899265503725;20651.380458586267;20677.89661051685;20705.5858882823;20760.37718868421;2465.161844972718;2507.9842663721224;2534.670492835938;2553.9872300638563;2564.974350256492;145338;151960;152475;152919.23540382338;153217;15527;15540.378384864705;15580.922095389451;15845.920770396075;16390.672186556203;23829.880850595637;23877;23878.641820372708;23879.283621491384;24375;11076.446177691083;11198;11284.548618055185;11326.773464530663;11351.375674337825;10412.791744165226;10427.947860260801;10458.63394781179;10483.895161048444;10567.418791966362;10235.437050962268;10249.180065594735;10252.743681407876;10360.222983276284;10446.63436779709;2753.8072334936364;2758.2001219646077;2798.572727908781;2826.6042754014456;2952.4242772659127;1043.6242952537082;1064.8189807732704;1065.6376831877044;1067.1302888146136;1070.3631339353071;20790.376288711363;21510.892445537673;21613.351599452042;21810.563788724136;21907.67138492924;1123.5112725964232;1138.9031932285682;1140.0993215359772;1141.7374003979132;1151.3955173533961;11528.538858445569;11807.527698891949;11846.229995050295;11904.583339583072;12046.879531204751;504770;507688;511392;524875;533665;134706.32646836704;135986;137132;137625;137954.31022844822;1248.3196657821509;1257.2330878164312;1267.512007876974;1273.6561128495255;1287.2533930320392;18613;18753.687241893484;18794.342198023005;18965.43103706891;19330.4200873974;60228.39771602403;60852.69573652103;64126.3587364139;68776.31223687899;69509;80706.59646701728;81663;81718.59140704258;82456;82785;14905.925470372578;15078.39686412575;15365.692686146438;15459.304331304893;15462.536123916301;24822.627660584745;24993.87503062473;25558.10546630859;25584;25609.359766005255;20059.69910451315;20120.798792011894;20302.59394812125;20336.08487618031;20509.794902051384;18039.549011274823;18146.637067258318;18266;18324.541886452946;18369.908150459163;20746.170153193703;20794.27220047291;21101.472463188544;21171.15315387367;21260;15151.696966060837;15192.924035379752;15292;15306.846931530543;15309.693806124038;20208.393748187576;20351.898240508704;20376;20637;20639.380818575468 20:25:03 INFO - PID 3545 | |3;mootools.html;1408.4577437686492;1468.6042285845137;1469.7427950108736;1473.064603976475;1483.325087085377;15883.126428046467;16323.34706611737;16488.258028388722;16516.999999999985;16541.586460338498;16229.51311460655;16521.83478165218;16531.83468165318;16600.833991660078;16623.750643740354;2661.268151258405;2679.5712685970248;2680;2685.328667833042;2686.90595829146;2729.7816174705977;2787.916362509118;2791.0091917369245;2793.706660800617;2794.2176190666546;2569.0879737693035;2580.561304578226;2590.4301053768236;2605;2608.2044976282227;2619.318977065967;2621.12192415542;2625.724298948602;2628.3297759071506;2630.684317881847;2418.6734790803193;2421.2010036687852;2421.33413311339;2422.285425799376;2422.9273121806373;15761.60595985098;16084.83915160845;16091;16097.275622596893;16123.516294511184;7945.602719863984;8241.83516329676;8301.46040507365;8354.791130221733;8574.571271436465;5135.717535535544;5271.20931860224;5300.496452836975;5326.627136100475;5373.113436283009;1727.1191692236923;1757.095096025548;1776.3960253513867;1784.6609144262547;1807.674618568657;28641.427171456453;28666.713332866613;28680.42639147226;28741.56887646687;28801.567976480368;6811.523193376515;6816.7614133505085;6838.48711346651;6936.7572134975035;6962.512624116364;19490.610187796447;19500.804991950183;19542.31601893927;19556.511087222934;19558.413247602595;8119.634616442274;8373;8386.329093672613;8410.537420441935;8416.831663366698;7549.0563679540055;7655.808604784814;7723.691052357843;7773.650185741655;7788;5149.510796474329;5320.893582128413;5331.546818520392;5396.64921780083;5407.594430417735;1576;1578.928948197334;1579.993408371362;1586.8016497937758;1597.4408956865236;891.919727224553;929.3169520402499;930.1489137439303;931.2736065868634;941.7174847545709;7945.682172713143;7966.721164759206;7973.960130199428;7992.400569957276;8009.719659811995;712.9697586986754;737.2995654128599;741.3550211316082;744.1739668967442;748.6780684305692;4864.343313652612;4961.007798440326;5919.3192782829665;5959.493443057302;6152.538559608047;22756.544869102527;23452.64821027686;23849.165279215493;24053;24088.51822963531;23200;23697.881510592335;23959.401014974766;23962.760372396053;24311.149109781072;12173.634790956285;12184.147109702235;12488;12502.437390317458;12532.185407948455;9436.150746432853;9726;9752.707418777449;9963.25275604318;10353.896461035294;20692.379228623166;20794.376168714964;20917.163313467292;21139.26012589552;21194.15223391047;20911.686324705446;21223.68164477503;21303.680444793652;21345.893270533546;21415.250466233607;13415.195088294733;13687.31563421805;13694.657633558842;13697.863021369658;13700.177989320673;15030.248487575796;15033.548993530212;15195.696086078438;15200.16399098016;15220.543383698507;11901.226420282654;11915.40422978865;12072.094592905392;12293;12416.751664966469;11578.247413918069;11734;11851.466683999068;12021.819672704742;12142.75714485723;10901.454927253764;11069.612563560237;11099.50052247667;11107.333559986426;11112.777744445228;7950.880736788837;8295.211954864279;8406.327493800603;8437.409381343492;8484;7984.640691169027;8013.318867896294;8110.513369197867;8111.107778144517;8216.424850260424 20:25:03 INFO - PID 3545 | |4;prototype.html;511.51406164144026;526.2895091626305;531.585363416535;535.7696190638026;536.2706718862347;6239.563230573862;6261.43647071764;6261.718222679979;6265.498760099193;6271.181357406346;6162.168107305512;6169.180091872897;6178.3512731163255;6191.288001879785;6210.472109870667;4874.293227482013;4889.315495830587;4918.753622609079;4921.729304888229;4938.901221975576;4898.314236006961;4980.950190498085;5021.17150670139;5040.949590504085;5047;4921.212605983025;4952.727599981999;4982.676126051813;4994.225894986283;4999.875003124933;4967.850964471072;4985.750712464399;4986;5007.346106563491;5021.14640511114;4646.86059418218;4650.000249946244;4669.299605059268;4698.107359601699;4713.175194340976;5973.163757074013;6023.879522409571;6089.1779609753;6129.938700612981;6159.1069294951985;5904.527637788967;5963.850903727398;5964.373740757202;6001.159837622737;6002.399760024006;6649.135612370409;6656.93343066568;6719.428848547879;6720.798376048726;6744.393004629558;5265.183896496049;5282.445343238982;5289.894202115975;5316.331731105563;5347.438518955492;6698.291935556451;6790.7623233186605;6792.184937807446;6953.130858642669;7031;5427.6200665953;5452.40023597404;5453.15476101205;5458.5087342139395;5465.316835395575;5507.669539827623;5539.446055394428;5545.445455454503;5558.944410555842;5577.382559057909;5926.436988486087;5984.1323008164445;5995.070764031582;6062.818115456544;6078.696065196811;6685.027916764566;6701.1623547056615;6704.195496540447;6711.530192886451;6738.292479289702;1928.2287085165765;1947.0848701110456;1949.3664559018375;1961.6959371297187;1966.606678664273;1386.2652794019186;1412.9222892740793;1431.7494438473434;1445.436279850859;1447.841726618701;6252.968735156295;6254.433554136822;6274.780382686584;6365.172527571479;6420.711068001951;6564.343565643398;6635.303293154246;6731.192256929102;6748.763793267212;6758.560693554903;6249.312575616678;6252.781152659635;6300.243970723543;6368;6394.625155591477;3557.2707594942976;3588.4976103345552;3603.9188243526837;3618.457231415309;3622.7826330420257;6949.131358580177;6961.582305061611;6995.93004069963;7077.964610176916;7129.394001509826;6894.586324820527;6974.4420446364165;6985.720571177096;6986.231514533397;6990.196127445307;7003.719851206099;7053.153621565445;7129.251428600026;7149.6067716275065;7178.533395329287;6651.800445986628;6666.799996000128;6692.397684208445;6696.899546506904;6742.022406751092;6696.029075784081;6715.160604924385;6732.730690772511;6742.595444273359;6752.459803215633;7151.356377926011;7155.821104472429;7161.677724502514;7184.533005354635;7205.531640443354;5506.5870059746485;5548.250986116823;5549.722513874371;5554.91667624994;5570.86072848182;6603.405693487609;6700.363465470772;6797.524173308018;6856.4514838813775;6890;6548.476121910331;6586.44332060701;6586.8353291168105;6617.867642647217;6651.767188148391;6578.111954886029;6583.934160658332;6603.778301014328;6612.991089054372;6624.8343791405605;6481.384268494486;6545.770898018546;6590.670466476753;6623.801285961429;6624.238212605612;6386.393292637192;6464.41820236181;6544.574602650812;6618.338166183343;6670.7665231716655;6459.838504037437;6465.903011454926;6470.579412338183;6489.020848641021;6490.1562796838 20:25:03 INFO - PID 3545 | |5;yui.html;933.6592143867487;942.996133216914;950.0357137505429;955.4965989108537;968.1431932739523;19311.903440482794;20137.899310503446;20157.596848063047;20190;22721.20475783348;22148.335549933487;22572.8871355643;22616.54766904665;22648;22675.433114172152;1006.4414250091196;1025.3898930136556;1025.6461520775358;1028.8765348158195;1029.2435060230762;1011.5245834457793;1040.105509262034;1079.967600971968;1083.0685610375072;1087.6573879228017;1131.383396049151;1147.8450409194777;1157.0801213035656;1157.1437136519;1157.6179860645966;1144.9885501144965;1150.6260465348712;1153.3368313219933;1154.0421450196359;1156.410230782303;843.7342237195264;848.4188330993289;849.9872501912477;850.0606829453488;850.4132148817358;20732.378028659165;20740.377788666363;20744.688829667568;20850;20889.37331880046;22382.77617223823;22594.774052259596;22986.195483158008;23125.999999999833;23285.76714232853;17392.652146957116;17805.198766055557;17932.282708691768;18014.90992545042;18095.72856407155;3842.9039274018373;3862.1310205203886;3863.826127824255;3864.516935383077;3868.4197370394386;130760.3461982684;131432;136163;136206;137594;16649.83350166507;17614.295428182984;17754.467365979042;17850.91074544619;17883.463496095137;33634.32731345359;35280.823595881855;35466.46800297998;35527;35579.82210088985;8375.95812020936;8784;8852.203301702877;8866.64533418656;8871.423357481743;4259.61663450291;4354.825806967686;4359.564043595615;4372.737635741865;4381.21138195128;5331.893362132813;5441.755121019563;5951.702414879239;6077.908831367533;6120.510359171256;1095.1239008792934;1124.8200287954053;1127.182792475465;1137.8179491281521;1142.948567314473;708.0759608710682;717.519262094398;717.5802155738951;730.5288089182447;741.7292688168887;12801.10392272532;13562.389692463863;13568.525101621395;13904.86095139056;14119.64700882486;649.9512536559682;664.9534532582769;669.464428457242;678.460623804067;680.5474359550843;6137.662428566382;6302.401271879165;6306.684665766693;6357.268914074941;6375.4262116409745;142609;143313;143939.2803035978;145388;146379.2681036588;122062.38968805099;122512.77487225192;125623.37188314;125649.37175314064;126018;109392;109429.45285273522;110409.44795276133;113303;114066.42966785113;11574.074074074222;11676.124290678403;11763.529458821893;11854.466549005143;11905.345206013752;51826.481735183675;52253;52614.73692631513;53299;53696.1945570809;65594;65623.67188164219;65693;66110.66944665246;69035.96446053413;17174.31302747926;17386.47840564785;17389.47831565055;17412.651746965243;17520;23227.3031809046;23452;23738.52522949566;24133.034678612657;24253.63619545673;20834.895825520776;21416.89291553532;21512.677309840677;21564.78435215628;21901.671474928207;19677.31129410464;19885.204591816164;20245.493862652962;20572.69140962857;20722;20423.489412764204;20905.581888362452;20924.895375523025;20931.686024709947;21109.05009274617;14160;14664.486742963945;14773.261336933325;14907.478238261609;15118.848811511743;16229.918850406144;16290.918545407198;16346.346146154021;16487.010779353277;16782.24479898383 20:25:03 INFO - PID 3545 | __end_tp_report 20:25:03 INFO - PID 3545 | __start_cc_report 20:25:03 INFO - PID 3545 | _x_x_mozilla_cycle_collect,335 20:25:03 INFO - PID 3545 | __end_cc_report 20:25:03 INFO - PID 3545 | __startTimestamp1502853903016__endTimestamp 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | ------- Summary: start ------- 20:25:03 INFO - PID 3545 | Number of tests: 6 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#0] dojo.html Cycles:165 Average:6228.07 Median:6541.48 stddev:821.55 (12.6%) stddev-sans-first:794.74 20:25:03 INFO - PID 3545 | Values: 3454.8 3507.4 3510.4 3512.5 3528.8 6083.0 6128.4 6141.7 6164.8 6168.3 6066.4 6183.8 6196.0 6196.7 6215.2 5420.5 5447.4 5474.8 5477.3 5506.3 5352.5 5395.5 5476.4 5478.6 5554.3 5413.8 5436.6 5526.4 5526.6 5541.3 5463.2 5485.6 5511.2 5546.4 5546.7 5338.1 5433.9 5480.2 5480.4 5526.8 6133.6 6135.9 6191.3 6231.4 6259.8 6795.9 6813.4 6818.8 6819.4 6829.4 6793.8 6800.1 6824.2 6877.2 6890.4 6169.8 6252.1 6329.3 6391.2 6401.9 6866.2 6909.9 6920.0 6923.2 7043.0 6496.3 6559.3 6750.4 6765.7 6766.7 6752.2 6756.4 6763.0 6768.8 6802.0 6686.4 6810.3 6816.8 6817.9 6832.6 6772.5 6790.1 6827.9 6836.4 6854.8 4800.1 4910.9 4932.9 4952.7 4967.1 4339.1 4368.0 4389.0 4418.8 4451.9 6436.2 6492.1 6496.1 6502.2 6503.1 6806.6 6808.6 6812.3 6891.8 6895.6 6393.3 6434.0 6491.4 6507.1 6514.8 5490.4 5514.3 5529.6 5531.2 5533.4 7100.9 7108.2 7166.8 7179.7 7187.2 6663.9 6739.7 6746.8 6756.1 6762.5 7134.8 7176.9 7198.5 7203.3 7205.4 6629.6 6689.0 6715.8 6769.8 6774.9 6729.1 6815.8 6818.5 6825.2 6902.9 6571.6 6580.7 6631.7 6641.9 6649.6 6614.2 6657.3 6685.5 6692.2 6696.4 6469.5 6573.2 6581.8 6657.5 6673.8 6525.4 6573.0 6596.0 6631.8 6650.1 6498.1 6517.4 6526.7 6532.2 6541.5 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#1] ext.html Cycles:180 Average:41620.79 Median:37892.81 stddev:61078.97 (161.2%) stddev-sans-first:61173.74 20:25:03 INFO - PID 3545 | Values: 888.9 901.1 935.1 945.7 951.8 40345.8 42294.8 42321.8 42360.2 42410.0 39163.6 39314.4 39426.8 39525.2 39536.8 6924.9 7020.4 7024.8 7025.3 7031.8 6892.7 7027.9 7028.4 7028.8 7032.4 7590.1 7688.1 7735.7 7766.0 7768.0 7597.7 7658.4 7731.6 7732.4 7738.4 7403.8 7607.7 7609.7 7610.7 7615.1 39535.2 39958.0 40003.6 40034.6 40047.0 3466.4 3517.3 3518.7 3519.6 3521.5 31269.1 31283.0 31292.8 31311.2 31326.0 5050.5 5073.4 5091.6 5105.3 5128.6 202071.0 202796.0 206644.0 209725.0 219485.0 52613.5 53288.0 53295.5 53366.7 53459.2 55330.0 55336.0 55371.7 55548.7 55596.4 16487.0 16600.1 16619.9 16707.0 16709.7 13299.9 13312.5 13320.7 13322.3 13480.8 15022.1 15040.5 15110.2 15124.7 15283.5 5696.2 5808.9 5873.2 5884.8 6006.5 1047.6 1058.2 1077.4 1085.5 1092.8 24797.3 24894.5 24950.9 25014.7 25051.4 1146.8 1188.7 1190.7 1193.4 1196.2 13172.2 13191.9 13254.6 13338.6 17235.7 265717.0 267512.0 267630.0 268180.0 270177.0 60576.0 60747.4 60774.0 60856.4 61158.7 1417.1 1446.5 1485.9 1488.2 1489.0 29057.6 29726.4 29924.7 30374.0 30545.8 40454.0 40645.0 40676.6 40743.6 40775.0 224091.0 224602.0 225430.0 225552.0 225624.0 35484.0 38606.8 39564.8 39587.0 39610.8 47668.3 48518.0 48773.0 48854.3 48884.3 35518.8 36662.3 36797.6 36980.8 37102.6 36063.6 36625.6 36707.4 37048.4 37178.8 40717.8 42301.2 42309.2 42458.4 42565.1 34949.3 35045.8 35294.6 35455.0 35551.6 26089.2 26514.7 26620.6 27265.9 27407.2 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#2] jquery.html Cycles:180 Average:37621.67 Median:21385.45 stddev:87806.32 (410.6%) stddev-sans-first:88008.56 20:25:03 INFO - PID 3545 | Values: 562.7 571.5 576.8 581.8 587.1 22714.7 23147.3 23573.5 23576.0 23603.6 25510.6 27148.0 27160.3 27228.7 27321.9 6323.7 6438.0 6447.4 6460.5 6467.0 6078.0 6288.8 6305.6 6318.7 6353.7 6279.1 6284.3 6284.7 6289.4 6305.9 6306.4 6308.8 6309.0 6314.6 6316.4 5856.4 5868.1 5869.3 5871.3 5885.5 29209.3 29697.4 30165.7 30487.8 30758.5 2256.1 2291.9 2292.4 2293.0 2294.0 20146.9 20651.4 20677.9 20705.6 20760.4 2465.2 2508.0 2534.7 2554.0 2565.0 145338.0 151960.0 152475.0 152919.2 153217.0 15527.0 15540.4 15580.9 15845.9 16390.7 23829.9 23877.0 23878.6 23879.3 24375.0 11076.4 11198.0 11284.5 11326.8 11351.4 10412.8 10427.9 10458.6 10483.9 10567.4 10235.4 10249.2 10252.7 10360.2 10446.6 2753.8 2758.2 2798.6 2826.6 2952.4 1043.6 1064.8 1065.6 1067.1 1070.4 20790.4 21510.9 21613.4 21810.6 21907.7 1123.5 1138.9 1140.1 1141.7 1151.4 11528.5 11807.5 11846.2 11904.6 12046.9 504770.0 507688.0 511392.0 524875.0 533665.0 134706.3 135986.0 137132.0 137625.0 137954.3 1248.3 1257.2 1267.5 1273.7 1287.3 18613.0 18753.7 18794.3 18965.4 19330.4 60228.4 60852.7 64126.4 68776.3 69509.0 80706.6 81663.0 81718.6 82456.0 82785.0 14905.9 15078.4 15365.7 15459.3 15462.5 24822.6 24993.9 25558.1 25584.0 25609.4 20059.7 20120.8 20302.6 20336.1 20509.8 18039.5 18146.6 18266.0 18324.5 18369.9 20746.2 20794.3 21101.5 21171.2 21260.0 15151.7 15192.9 15292.0 15306.8 15309.7 20208.4 20351.9 20376.0 20637.0 20639.4 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#3] mootools.html Cycles:180 Average:10114.90 Median:13440.12 stddev:7447.16 (55.4%) stddev-sans-first:7439.32 20:25:03 INFO - PID 3545 | Values: 1408.5 1468.6 1469.7 1473.1 1483.3 15883.1 16323.3 16488.3 16517.0 16541.6 16229.5 16521.8 16531.8 16600.8 16623.8 2661.3 2679.6 2680.0 2685.3 2686.9 2729.8 2787.9 2791.0 2793.7 2794.2 2569.1 2580.6 2590.4 2605.0 2608.2 2619.3 2621.1 2625.7 2628.3 2630.7 2418.7 2421.2 2421.3 2422.3 2422.9 15761.6 16084.8 16091.0 16097.3 16123.5 7945.6 8241.8 8301.5 8354.8 8574.6 5135.7 5271.2 5300.5 5326.6 5373.1 1727.1 1757.1 1776.4 1784.7 1807.7 28641.4 28666.7 28680.4 28741.6 28801.6 6811.5 6816.8 6838.5 6936.8 6962.5 19490.6 19500.8 19542.3 19556.5 19558.4 8119.6 8373.0 8386.3 8410.5 8416.8 7549.1 7655.8 7723.7 7773.7 7788.0 5149.5 5320.9 5331.5 5396.6 5407.6 1576.0 1578.9 1580.0 1586.8 1597.4 891.9 929.3 930.1 931.3 941.7 7945.7 7966.7 7974.0 7992.4 8009.7 713.0 737.3 741.4 744.2 748.7 4864.3 4961.0 5919.3 5959.5 6152.5 22756.5 23452.6 23849.2 24053.0 24088.5 23200.0 23697.9 23959.4 23962.8 24311.1 12173.6 12184.1 12488.0 12502.4 12532.2 9436.2 9726.0 9752.7 9963.3 10353.9 20692.4 20794.4 20917.2 21139.3 21194.2 20911.7 21223.7 21303.7 21345.9 21415.3 13415.2 13687.3 13694.7 13697.9 13700.2 15030.2 15033.5 15195.7 15200.2 15220.5 11901.2 11915.4 12072.1 12293.0 12416.8 11578.2 11734.0 11851.5 12021.8 12142.8 10901.5 11069.6 11099.5 11107.3 11112.8 7950.9 8295.2 8406.3 8437.4 8484.0 7984.6 8013.3 8110.5 8111.1 8216.4 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#4] prototype.html Cycles:180 Average:5699.82 Median:6261.58 stddev:1561.84 (24.9%) stddev-sans-first:1516.90 20:25:03 INFO - PID 3545 | Values: 511.5 526.3 531.6 535.8 536.3 6239.6 6261.4 6261.7 6265.5 6271.2 6162.2 6169.2 6178.4 6191.3 6210.5 4874.3 4889.3 4918.8 4921.7 4938.9 4898.3 4981.0 5021.2 5040.9 5047.0 4921.2 4952.7 4982.7 4994.2 4999.9 4967.9 4985.8 4986.0 5007.3 5021.1 4646.9 4650.0 4669.3 4698.1 4713.2 5973.2 6023.9 6089.2 6129.9 6159.1 5904.5 5963.9 5964.4 6001.2 6002.4 6649.1 6656.9 6719.4 6720.8 6744.4 5265.2 5282.4 5289.9 5316.3 5347.4 6698.3 6790.8 6792.2 6953.1 7031.0 5427.6 5452.4 5453.2 5458.5 5465.3 5507.7 5539.4 5545.4 5558.9 5577.4 5926.4 5984.1 5995.1 6062.8 6078.7 6685.0 6701.2 6704.2 6711.5 6738.3 1928.2 1947.1 1949.4 1961.7 1966.6 1386.3 1412.9 1431.7 1445.4 1447.8 6253.0 6254.4 6274.8 6365.2 6420.7 6564.3 6635.3 6731.2 6748.8 6758.6 6249.3 6252.8 6300.2 6368.0 6394.6 3557.3 3588.5 3603.9 3618.5 3622.8 6949.1 6961.6 6995.9 7078.0 7129.4 6894.6 6974.4 6985.7 6986.2 6990.2 7003.7 7053.2 7129.3 7149.6 7178.5 6651.8 6666.8 6692.4 6696.9 6742.0 6696.0 6715.2 6732.7 6742.6 6752.5 7151.4 7155.8 7161.7 7184.5 7205.5 5506.6 5548.3 5549.7 5554.9 5570.9 6603.4 6700.4 6797.5 6856.5 6890.0 6548.5 6586.4 6586.8 6617.9 6651.8 6578.1 6583.9 6603.8 6613.0 6624.8 6481.4 6545.8 6590.7 6623.8 6624.2 6386.4 6464.4 6544.6 6618.3 6670.8 6459.8 6465.9 6470.6 6489.0 6490.2 20:25:03 INFO - PID 3545 | 20:25:03 INFO - PID 3545 | [#5] yui.html Cycles:180 Average:27463.83 Median:20736.38 stddev:38743.19 (186.8%) stddev-sans-first:38800.66 20:25:03 INFO - PID 3545 | Values: 933.7 943.0 950.0 955.5 968.1 19311.9 20137.9 20157.6 20190.0 22721.2 22148.3 22572.9 22616.5 22648.0 22675.4 1006.4 1025.4 1025.6 1028.9 1029.2 1011.5 1040.1 1080.0 1083.1 1087.7 1131.4 1147.8 1157.1 1157.1 1157.6 1145.0 1150.6 1153.3 1154.0 1156.4 843.7 848.4 850.0 850.1 850.4 20732.4 20740.4 20744.7 20850.0 20889.4 22382.8 22594.8 22986.2 23126.0 23285.8 17392.7 17805.2 17932.3 18014.9 18095.7 3842.9 3862.1 3863.8 3864.5 3868.4 130760.3 131432.0 136163.0 136206.0 137594.0 16649.8 17614.3 17754.5 17850.9 17883.5 33634.3 35280.8 35466.5 35527.0 35579.8 8376.0 8784.0 8852.2 8866.6 8871.4 4259.6 4354.8 4359.6 4372.7 4381.2 5331.9 5441.8 5951.7 6077.9 6120.5 1095.1 1124.8 1127.2 1137.8 1142.9 708.1 717.5 717.6 730.5 741.7 12801.1 13562.4 13568.5 13904.9 14119.6 650.0 665.0 669.5 678.5 680.5 6137.7 6302.4 6306.7 6357.3 6375.4 142609.0 143313.0 143939.3 145388.0 146379.3 122062.4 122512.8 125623.4 125649.4 126018.0 109392.0 109429.5 110409.4 113303.0 114066.4 11574.1 11676.1 11763.5 11854.5 11905.3 51826.5 52253.0 52614.7 53299.0 53696.2 65594.0 65623.7 65693.0 66110.7 69036.0 17174.3 17386.5 17389.5 17412.7 17520.0 23227.3 23452.0 23738.5 24133.0 24253.6 20834.9 21416.9 21512.7 21564.8 21901.7 19677.3 19885.2 20245.5 20572.7 20722.0 20423.5 20905.6 20924.9 20931.7 21109.1 14160.0 14664.5 14773.3 14907.5 15118.8 16229.9 16290.9 16346.3 16487.0 16782.2 20:25:03 INFO - PID 3545 | -------- Summary: end -------- 20:25:03 INFO - PID 3545 | 20:25:03 INFO - TEST-INFO | 3545: exit 0 20:25:03 INFO - TEST-OK | dromaeo_css | took 1111206ms 20:25:03 INFO - TEST-START | kraken 20:25:03 INFO - Initialising browser for kraken test... 20:25:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51800/getInfo.html -profile /tmp/tmpK5Kh5q/profile 20:25:03 INFO - TEST-INFO | started process 3910 (/builds/slave/test/build/application/firefox/firefox http://localhost:51800/getInfo.html) 20:25:09 INFO - TEST-INFO | 3910: exit 0 20:25:09 INFO - Browser initialized. 20:25:09 INFO - Running cycle 1/1 for kraken test... 20:25:09 INFO - TEST-INFO | started process 4122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5Kh5q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:10 INFO - PID 4122 | 20:25:10 INFO - PID 4122 | (/builds/slave/test/build/application/firefox/firefox:4171): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:25:10 INFO - PID 4122 | 20:25:20 INFO - PID 4122 | RSS: Main: 158261248 20:25:20 INFO - PID 4122 | 20:25:23 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51800/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:24 INFO - PID 4122 | RSS: Main: 165888000 20:25:24 INFO - PID 4122 | 20:25:26 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51800/tests/kraken/driver.html?testName=audio-dft) 20:25:27 INFO - PID 4122 | RSS: Main: 169545728 20:25:27 INFO - PID 4122 | 20:25:30 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51800/tests/kraken/driver.html?testName=audio-fft) 20:25:30 INFO - PID 4122 | RSS: Main: 161660928 20:25:30 INFO - PID 4122 | 20:25:32 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51800/tests/kraken/driver.html?testName=audio-oscillator) 20:25:33 INFO - PID 4122 | RSS: Main: 162959360 20:25:33 INFO - PID 4122 | 20:25:35 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:36 INFO - PID 4122 | RSS: Main: 162488320 20:25:36 INFO - PID 4122 | 20:25:39 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51800/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:39 INFO - PID 4122 | RSS: Main: 163553280 20:25:39 INFO - PID 4122 | 20:25:43 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51800/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:43 INFO - PID 4122 | RSS: Main: 166612992 20:25:43 INFO - PID 4122 | 20:25:46 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51800/tests/kraken/driver.html?testName=json-parse-financial) 20:25:47 INFO - PID 4122 | RSS: Main: 165163008 20:25:47 INFO - PID 4122 | 20:25:48 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:49 INFO - PID 4122 | RSS: Main: 164843520 20:25:49 INFO - PID 4122 | 20:25:51 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:51 INFO - PID 4122 | RSS: Main: 165023744 20:25:51 INFO - PID 4122 | 20:25:53 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:54 INFO - PID 4122 | RSS: Main: 164937728 20:25:54 INFO - PID 4122 | 20:25:57 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:57 INFO - PID 4122 | RSS: Main: 164773888 20:25:57 INFO - PID 4122 | 20:26:00 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:01 INFO - PID 4122 | RSS: Main: 165158912 20:26:01 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | Cycle 1(1): loaded http://localhost:51800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51800/tests/kraken/driver.html?testName=ai-astar) 20:26:03 INFO - PID 4122 | RSS: Main: 166916096 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | __start_tp_report 20:26:03 INFO - PID 4122 | _x_x_mozilla_page_load 20:26:03 INFO - PID 4122 | _x_x_mozilla_page_load_details 20:26:03 INFO - PID 4122 | |i|pagename|runs| 20:26:03 INFO - PID 4122 | |0;ai-astar;97;105;98;106;107;111;108;97;106;108 20:26:03 INFO - PID 4122 | |1;audio-beat-detection;138;111;136;172;112;137;138;119;164;115 20:26:03 INFO - PID 4122 | |2;audio-dft;165;162;162;162;161;161;162;161;165;167 20:26:03 INFO - PID 4122 | |3;audio-fft;76;77;74;186;74;74;73;75;167;74 20:26:03 INFO - PID 4122 | |4;audio-oscillator;78;78;136;77;78;79;135;78;78;130 20:26:03 INFO - PID 4122 | |5;imaging-gaussian-blur;114;113;115;114;114;115;115;114;114;114 20:26:03 INFO - PID 4122 | |6;imaging-darkroom;148;149;148;149;148;149;148;150;149;151 20:26:03 INFO - PID 4122 | |7;imaging-desaturate;101;94;94;95;94;94;94;94;95;94 20:26:03 INFO - PID 4122 | |8;json-parse-financial;48;47;48;48;48;50;50;47;49;47 20:26:03 INFO - PID 4122 | |9;json-stringify-tinderbox;54;54;54;55;55;55;55;55;55;55 20:26:03 INFO - PID 4122 | |10;stanford-crypto-aes;81;75;74;73;74;73;74;74;74;74 20:26:03 INFO - PID 4122 | |11;stanford-crypto-ccm;140;115;116;117;116;113;118;130;117;164 20:26:03 INFO - PID 4122 | |12;stanford-crypto-pbkdf2;171;160;165;164;161;167;172;165;169;179 20:26:03 INFO - PID 4122 | |13;stanford-crypto-sha256-iterative;63;60;60;62;60;61;61;63;64;62 20:26:03 INFO - PID 4122 | __end_tp_report 20:26:03 INFO - PID 4122 | __start_cc_report 20:26:03 INFO - PID 4122 | _x_x_mozilla_cycle_collect,835 20:26:03 INFO - PID 4122 | __end_cc_report 20:26:03 INFO - PID 4122 | __startTimestamp1502853963248__endTimestamp 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | ------- Summary: start ------- 20:26:03 INFO - PID 4122 | Number of tests: 14 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#0] ai-astar Cycles:10 Average:104.30 Median:109.50 stddev:5.08 (4.6%) stddev-sans-first:4.65 20:26:03 INFO - PID 4122 | Values: 97.0 105.0 98.0 106.0 107.0 111.0 108.0 97.0 106.0 108.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:137.50 stddev:21.05 (15.3%) stddev-sans-first:22.28 20:26:03 INFO - PID 4122 | Values: 138.0 111.0 136.0 172.0 112.0 137.0 138.0 119.0 164.0 115.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.10 (1.3%) stddev-sans-first:2.07 20:26:03 INFO - PID 4122 | Values: 165.0 162.0 162.0 162.0 161.0 161.0 162.0 161.0 165.0 167.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#3] audio-fft Cycles:10 Average:95.00 Median:74.00 stddev:43.20 (58.4%) stddev-sans-first:45.27 20:26:03 INFO - PID 4122 | Values: 76.0 77.0 74.0 186.0 74.0 74.0 73.0 75.0 167.0 74.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:78.00 stddev:26.94 (34.5%) stddev-sans-first:27.88 20:26:03 INFO - PID 4122 | Values: 78.0 78.0 136.0 77.0 78.0 79.0 135.0 78.0 78.0 130.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 20:26:03 INFO - PID 4122 | Values: 114.0 113.0 115.0 114.0 114.0 115.0 115.0 114.0 114.0 114.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 20:26:03 INFO - PID 4122 | Values: 148.0 149.0 148.0 149.0 148.0 149.0 148.0 150.0 149.0 151.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.18 (2.3%) stddev-sans-first:0.44 20:26:03 INFO - PID 4122 | Values: 101.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.00 stddev:1.14 (2.4%) stddev-sans-first:1.20 20:26:03 INFO - PID 4122 | Values: 48.0 47.0 48.0 48.0 48.0 50.0 50.0 47.0 49.0 47.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 20:26:03 INFO - PID 4122 | Values: 54.0 54.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.32 (3.1%) stddev-sans-first:0.60 20:26:03 INFO - PID 4122 | Values: 81.0 75.0 74.0 73.0 74.0 73.0 74.0 74.0 74.0 74.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:117.50 stddev:16.17 (13.8%) stddev-sans-first:16.16 20:26:03 INFO - PID 4122 | Values: 140.0 115.0 116.0 117.0 116.0 113.0 118.0 130.0 117.0 164.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:5.68 (3.4%) stddev-sans-first:5.86 20:26:03 INFO - PID 4122 | Values: 171.0 160.0 165.0 164.0 161.0 167.0 172.0 165.0 169.0 179.0 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.43 (2.3%) stddev-sans-first:1.42 20:26:03 INFO - PID 4122 | Values: 63.0 60.0 60.0 62.0 60.0 61.0 61.0 63.0 64.0 62.0 20:26:03 INFO - PID 4122 | -------- Summary: end -------- 20:26:03 INFO - PID 4122 | 20:26:03 INFO - PID 4122 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:26:03 INFO - TEST-INFO | 4122: exit 0 20:26:03 INFO - TEST-OK | kraken | took 60249ms 20:26:03 INFO - SUITE-END | took 1171s 20:26:03 INFO - Completed test suite (00:19:31) 20:26:03 INFO - javascript benchmark 20:26:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8991.89077751386, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3454.8445319960615, 3507.3686736387453, 3510.403231450653, 3512.5082488451635, 3528.841202145903, 6083.026715725479, 6128.417800308975, 6141.72362243699, 6164.845878853025, 6168.290646575645, 6066.423689749467, 6183.814485565429, 6196.008638617822, 6196.72114754836, 6215.223097112861, 5420.512153906147, 5447.400785913546, 5474.808381706641, 5477.315335583052, 5506.284183056197, 5352.464753524655, 5395.460453954613, 5476.3702174249875, 5478.58910581706, 5554.250176226218, 5413.756380962846, 5436.619436639437, 5526.447355264441, 5526.557875369961, 5541.307336582927, 5463.235147079412, 5485.588580856452, 5511.173324001432, 5546.417626149277, 5546.69493177875, 5338.145896656555, 5433.945660543383, 5480.177973303997, 5480.3971563128025, 5526.806561770319, 6133.601315914496, 6135.9079613805825, 6191.318954914956, 6231.40801623845, 6259.843503912393, 6795.898061529081, 6813.4208592269715, 6818.829529261759, 6819.386255237053, 6829.385355318045, 6793.796186114425, 6800.149981252343, 6824.21521525021, 6877.2091209511045, 6890.44876409886, 6169.7840575580085, 6252.124702541648, 6329.335419780903, 6391.2330520337855, 6401.935980640227, 6866.244713081557, 6909.930900690929, 6920.0, 6923.2038315594355, 7043.0, 6496.317886621931, 6559.278479367265, 6750.392464678104, 6765.729370825112, 6766.661666916634, 6752.22349429812, 6756.391924726799, 6763.0, 6768.830779230559, 6802.01370801231, 6686.431653309426, 6810.250872404032, 6816.761413350609, 6817.863642727118, 6832.59004459734, 6772.458203343721, 6790.083338749206, 6827.897581536281, 6836.38472537474, 6854.828629284308, 4800.1119792838435, 4910.8772280693265, 4932.8520144395725, 4952.727599982036, 4967.105920934194, 4339.088791353851, 4367.956320436755, 4388.956110438919, 4418.756968366771, 4451.910961780746, 6436.16329877113, 6492.123563318892, 6496.123023391876, 6502.154719886479, 6503.122078519339, 6806.591604503746, 6808.62552559614, 6812.318768123148, 6891.793246202622, 6895.55178913369, 6393.264774550986, 6433.967830160819, 6491.383318584727, 6507.12153859223, 6514.837129071811, 5490.368607610176, 5514.255575497336, 5529.612927095065, 5531.197976293495, 5533.363663178786, 7100.92899071013, 7108.182559005677, 7166.820829479409, 7179.676914538858, 7187.245339239409, 6663.900041499284, 6739.6967136478, 6746.831329216612, 6756.054152418764, 6762.459003279824, 7134.750283740044, 7176.892346614909, 7198.460115491254, 7203.279672032964, 7205.3515183631625, 6629.569078010107, 6689.0, 6715.832104197239, 6769.830754231184, 6774.86450270982, 6729.0915726376315, 6815.761448349284, 6818.454523637998, 6825.249222585611, 6902.8619427612175, 6571.638559879252, 6580.670966451563, 6631.6684165792485, 6641.867162656623, 6649.63427011519, 6614.173228346457, 6657.3342665733035, 6685.498587605852, 6692.196936367667, 6696.430803381572, 6469.547131700736, 6573.211214654081, 6581.835454113494, 6657.467402607683, 6673.766418175341, 6525.3800888915475, 6572.967135164294, 6596.0435736816935, 6631.767888123893, 6650.068990341259, 6498.122753428227, 6517.4460170886005, 6526.706298216497, 6532.248791388861, 6541.476681865344], "value": 6164.25692246376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8800410099191, 901.1079031758561, 935.1303287942213, 945.7068308824265, 951.7810903492201, 40345.79827100864, 42294.788526057324, 42321.78839105804, 42360.15279694404, 42409.99999999996, 39163.608363916355, 39314.41028384576, 39426.80286598563, 39525.209495810064, 39536.802315988454, 6924.9307506924915, 7020.3681668649815, 7024.754133605325, 7025.297470252985, 7031.753888613899, 6892.655367231643, 7027.9297207027785, 7028.367446929801, 7028.824279393005, 7032.437405007613, 7590.089189297292, 7688.077430708323, 7735.690572377098, 7766.0, 7768.0, 7597.658105385271, 7658.425618078639, 7731.613419329039, 7732.381409487284, 7738.380929525624, 7403.777886663409, 7607.695692172307, 7609.7336593219525, 7610.657520411595, 7615.124260710034, 39535.20929581421, 39958.0, 40003.59996400028, 40034.59965400338, 40047.0, 3466.4280393735257, 3517.296540691872, 3518.7185025197923, 3519.577650681909, 3521.454174602941, 31269.061928142193, 31283.0, 31292.843535782402, 31311.217219569466, 31326.0, 5050.469700681412, 5073.365829271341, 5091.61812864033, 5105.310783044279, 5128.589712822965, 202071.0, 202796.0, 206644.0, 209725.0, 219484.9999999984, 52613.47386526086, 53288.0, 53295.467045329824, 53366.73316633392, 53459.19811202835, 55330.0, 55336.0, 55371.723141384035, 55548.722256389265, 55596.444035559936, 16487.0, 16600.08699521538, 16619.91690041542, 16707.0, 16709.749353759704, 13299.933500332436, 13312.46750129984, 13320.733585328433, 13322.333883305795, 13480.797788033187, 15022.09867407959, 15040.548783536511, 15110.168940708147, 15124.697506049817, 15283.541493755205, 5696.174054762119, 5808.854778630483, 5873.177755114288, 5884.823455296348, 6006.5495087868585, 1047.61238341814, 1058.227493929436, 1077.3966578715945, 1085.478970094359, 1092.814221582317, 24797.25608231756, 24894.502109958063, 24950.875245623654, 25014.749852501605, 25051.373715657253, 1146.8451759012594, 1188.744419949715, 1190.7082764722525, 1193.3591311946075, 1196.246364790194, 13172.209667419986, 13191.934040329928, 13254.602361929157, 13338.599842004756, 17235.65528689444, 265717.0, 267512.0, 267630.0, 268180.0, 270177.0, 60576.0, 60747.392526074174, 60774.0, 60856.391436085956, 61158.694206528686, 1417.1426287096158, 1446.4937271954732, 1485.8514148585054, 1488.1815001748994, 1488.970220595582, 29057.564136537545, 29726.405471890874, 29924.70075299219, 30374.0, 30545.847270763505, 40454.0, 40645.0, 40676.59323406847, 40743.59256407398, 40774.999999998814, 224091.0, 224602.0, 225430.0, 225552.0, 225624.0, 35484.0, 38606.80696596499, 39564.80217598894, 39587.0, 39610.80194599008, 47668.284975726085, 48518.0, 48773.0, 48854.26718599295, 48884.26673599828, 35518.822405887804, 36662.26675466529, 36797.63202367942, 36980.81509592435, 37102.628973709914, 36063.63936360603, 36625.63374366329, 36707.44938825866, 37048.43424007528, 37178.81410593038, 40717.796411017756, 42301.153976920905, 42309.1538169241, 42458.363124553776, 42565.148697025266, 34949.30101397907, 35045.824770877, 35294.64705353016, 35455.0, 35551.644483555865, 26089.217323480327, 26514.734852651225, 26620.60069099004, 27265.86367068152, 27407.17778466649], "value": 18268.160488064175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6708375600274, 571.5456212311212, 576.7772322675925, 581.813819577735, 587.1075964533909, 22714.659280110813, 23147.30558083256, 23573.528529429444, 23576.0, 23603.645945310793, 25510.617340739904, 27148.0, 27160.32099197521, 27228.727712722917, 27321.86339068307, 6323.683815809202, 6438.002109673008, 6447.419732224099, 6460.547761656686, 6467.0, 6077.969610151965, 6288.842778930541, 6305.558610897239, 6318.684065796715, 6353.682315884211, 6279.089532017854, 6284.277308109557, 6284.71718772654, 6289.371062893697, 6305.9369406305805, 6306.432421082101, 6308.779192728255, 6308.968455157741, 6314.557980941336, 6316.368363163693, 5856.355800861902, 5868.09044598088, 5869.325027621793, 5871.295444546682, 5885.529157667376, 29209.269768255752, 29697.406051878843, 30165.69834301651, 30487.847560762053, 30758.53862192069, 2256.0862850545554, 2291.862488250694, 2292.4383526036227, 2292.988535057314, 2293.9655905161435, 20146.899265503725, 20651.380458586267, 20677.89661051685, 20705.5858882823, 20760.37718868421, 2465.161844972718, 2507.9842663721224, 2534.670492835938, 2553.9872300638563, 2564.974350256492, 145338.0, 151960.0, 152475.0, 152919.23540382338, 153217.0, 15527.0, 15540.378384864705, 15580.922095389451, 15845.920770396075, 16390.672186556203, 23829.880850595637, 23877.0, 23878.641820372708, 23879.283621491384, 24375.0, 11076.446177691083, 11198.0, 11284.548618055185, 11326.773464530663, 11351.375674337825, 10412.791744165226, 10427.947860260801, 10458.63394781179, 10483.895161048444, 10567.418791966362, 10235.437050962268, 10249.180065594735, 10252.743681407876, 10360.222983276284, 10446.63436779709, 2753.8072334936364, 2758.2001219646077, 2798.572727908781, 2826.6042754014456, 2952.4242772659127, 1043.6242952537082, 1064.8189807732704, 1065.6376831877044, 1067.1302888146136, 1070.3631339353071, 20790.376288711363, 21510.892445537673, 21613.351599452042, 21810.563788724136, 21907.67138492924, 1123.5112725964232, 1138.9031932285682, 1140.0993215359772, 1141.7374003979132, 1151.3955173533961, 11528.538858445569, 11807.527698891949, 11846.229995050295, 11904.583339583072, 12046.879531204751, 504770.0, 507688.0, 511392.0, 524875.0, 533665.0, 134706.32646836704, 135986.0, 137132.0, 137625.0, 137954.31022844822, 1248.3196657821509, 1257.2330878164312, 1267.512007876974, 1273.6561128495255, 1287.2533930320392, 18613.0, 18753.687241893484, 18794.342198023005, 18965.43103706891, 19330.4200873974, 60228.39771602403, 60852.69573652103, 64126.3587364139, 68776.31223687899, 69509.0, 80706.59646701728, 81663.0, 81718.59140704258, 82456.0, 82785.0, 14905.925470372578, 15078.39686412575, 15365.692686146438, 15459.304331304893, 15462.536123916301, 24822.627660584745, 24993.87503062473, 25558.10546630859, 25584.0, 25609.359766005255, 20059.69910451315, 20120.798792011894, 20302.59394812125, 20336.08487618031, 20509.794902051384, 18039.549011274823, 18146.637067258318, 18266.0, 18324.541886452946, 18369.908150459163, 20746.170153193703, 20794.27220047291, 21101.472463188544, 21171.15315387367, 21260.0, 15151.696966060837, 15192.924035379752, 15292.0, 15306.846931530543, 15309.693806124038, 20208.393748187576, 20351.898240508704, 20376.0, 20637.0, 20639.380818575468], "value": 12741.027860836459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.4577437686492, 1468.6042285845137, 1469.7427950108736, 1473.064603976475, 1483.325087085377, 15883.126428046467, 16323.34706611737, 16488.258028388722, 16516.999999999985, 16541.586460338498, 16229.51311460655, 16521.83478165218, 16531.83468165318, 16600.833991660078, 16623.750643740354, 2661.268151258405, 2679.5712685970248, 2680.0, 2685.328667833042, 2686.90595829146, 2729.7816174705977, 2787.916362509118, 2791.0091917369245, 2793.706660800617, 2794.2176190666546, 2569.0879737693035, 2580.561304578226, 2590.4301053768236, 2605.0, 2608.2044976282227, 2619.318977065967, 2621.12192415542, 2625.724298948602, 2628.3297759071506, 2630.684317881847, 2418.6734790803193, 2421.2010036687852, 2421.33413311339, 2422.285425799376, 2422.9273121806373, 15761.60595985098, 16084.83915160845, 16091.0, 16097.275622596893, 16123.516294511184, 7945.602719863984, 8241.83516329676, 8301.46040507365, 8354.791130221733, 8574.571271436465, 5135.717535535544, 5271.20931860224, 5300.496452836975, 5326.627136100475, 5373.113436283009, 1727.1191692236923, 1757.095096025548, 1776.3960253513867, 1784.6609144262547, 1807.674618568657, 28641.427171456453, 28666.713332866613, 28680.42639147226, 28741.56887646687, 28801.567976480368, 6811.523193376515, 6816.7614133505085, 6838.48711346651, 6936.7572134975035, 6962.512624116364, 19490.610187796447, 19500.804991950183, 19542.31601893927, 19556.511087222934, 19558.413247602595, 8119.634616442274, 8373.0, 8386.329093672613, 8410.537420441935, 8416.831663366698, 7549.0563679540055, 7655.808604784814, 7723.691052357843, 7773.650185741655, 7788.0, 5149.510796474329, 5320.893582128413, 5331.546818520392, 5396.64921780083, 5407.594430417735, 1576.0, 1578.928948197334, 1579.993408371362, 1586.8016497937758, 1597.4408956865236, 891.919727224553, 929.3169520402499, 930.1489137439303, 931.2736065868634, 941.7174847545709, 7945.682172713143, 7966.721164759206, 7973.960130199428, 7992.400569957276, 8009.719659811995, 712.9697586986754, 737.2995654128599, 741.3550211316082, 744.1739668967442, 748.6780684305692, 4864.343313652612, 4961.007798440326, 5919.3192782829665, 5959.493443057302, 6152.538559608047, 22756.544869102527, 23452.64821027686, 23849.165279215493, 24053.0, 24088.51822963531, 23200.0, 23697.881510592335, 23959.401014974766, 23962.760372396053, 24311.149109781072, 12173.634790956285, 12184.147109702235, 12488.0, 12502.437390317458, 12532.185407948455, 9436.150746432853, 9726.0, 9752.707418777449, 9963.25275604318, 10353.896461035294, 20692.379228623166, 20794.376168714964, 20917.163313467292, 21139.26012589552, 21194.15223391047, 20911.686324705446, 21223.68164477503, 21303.680444793652, 21345.893270533546, 21415.250466233607, 13415.195088294733, 13687.31563421805, 13694.657633558842, 13697.863021369658, 13700.177989320673, 15030.248487575796, 15033.548993530212, 15195.696086078438, 15200.16399098016, 15220.543383698507, 11901.226420282654, 11915.40422978865, 12072.094592905392, 12293.0, 12416.751664966469, 11578.247413918069, 11734.0, 11851.466683999068, 12021.819672704742, 12142.75714485723, 10901.454927253764, 11069.612563560237, 11099.50052247667, 11107.333559986426, 11112.777744445228, 7950.880736788837, 8295.211954864279, 8406.327493800603, 8437.409381343492, 8484.0, 7984.640691169027, 8013.318867896294, 8110.513369197867, 8111.107778144517, 8216.424850260424], "value": 6993.457658696021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.51406164144026, 526.2895091626305, 531.585363416535, 535.7696190638026, 536.2706718862347, 6239.563230573862, 6261.43647071764, 6261.718222679979, 6265.498760099193, 6271.181357406346, 6162.168107305512, 6169.180091872897, 6178.3512731163255, 6191.288001879785, 6210.472109870667, 4874.293227482013, 4889.315495830587, 4918.753622609079, 4921.729304888229, 4938.901221975576, 4898.314236006961, 4980.950190498085, 5021.17150670139, 5040.949590504085, 5047.0, 4921.212605983025, 4952.727599981999, 4982.676126051813, 4994.225894986283, 4999.875003124933, 4967.850964471072, 4985.750712464399, 4986.0, 5007.346106563491, 5021.14640511114, 4646.86059418218, 4650.000249946244, 4669.299605059268, 4698.107359601699, 4713.175194340976, 5973.163757074013, 6023.879522409571, 6089.1779609753, 6129.938700612981, 6159.1069294951985, 5904.527637788967, 5963.850903727398, 5964.373740757202, 6001.159837622737, 6002.399760024006, 6649.135612370409, 6656.93343066568, 6719.428848547879, 6720.798376048726, 6744.393004629558, 5265.183896496049, 5282.445343238982, 5289.894202115975, 5316.331731105563, 5347.438518955492, 6698.291935556451, 6790.7623233186605, 6792.184937807446, 6953.130858642669, 7031.0, 5427.6200665953, 5452.40023597404, 5453.15476101205, 5458.5087342139395, 5465.316835395575, 5507.669539827623, 5539.446055394428, 5545.445455454503, 5558.944410555842, 5577.382559057909, 5926.436988486087, 5984.1323008164445, 5995.070764031582, 6062.818115456544, 6078.696065196811, 6685.027916764566, 6701.1623547056615, 6704.195496540447, 6711.530192886451, 6738.292479289702, 1928.2287085165765, 1947.0848701110456, 1949.3664559018375, 1961.6959371297187, 1966.606678664273, 1386.2652794019186, 1412.9222892740793, 1431.7494438473434, 1445.436279850859, 1447.841726618701, 6252.968735156295, 6254.433554136822, 6274.780382686584, 6365.172527571479, 6420.711068001951, 6564.343565643398, 6635.303293154246, 6731.192256929102, 6748.763793267212, 6758.560693554903, 6249.312575616678, 6252.781152659635, 6300.243970723543, 6368.0, 6394.625155591477, 3557.2707594942976, 3588.4976103345552, 3603.9188243526837, 3618.457231415309, 3622.7826330420257, 6949.131358580177, 6961.582305061611, 6995.93004069963, 7077.964610176916, 7129.394001509826, 6894.586324820527, 6974.4420446364165, 6985.720571177096, 6986.231514533397, 6990.196127445307, 7003.719851206099, 7053.153621565445, 7129.251428600026, 7149.6067716275065, 7178.533395329287, 6651.800445986628, 6666.799996000128, 6692.397684208445, 6696.899546506904, 6742.022406751092, 6696.029075784081, 6715.160604924385, 6732.730690772511, 6742.595444273359, 6752.459803215633, 7151.356377926011, 7155.821104472429, 7161.677724502514, 7184.533005354635, 7205.531640443354, 5506.5870059746485, 5548.250986116823, 5549.722513874371, 5554.91667624994, 5570.86072848182, 6603.405693487609, 6700.363465470772, 6797.524173308018, 6856.4514838813775, 6890.0, 6548.476121910331, 6586.44332060701, 6586.8353291168105, 6617.867642647217, 6651.767188148391, 6578.111954886029, 6583.934160658332, 6603.778301014328, 6612.991089054372, 6624.8343791405605, 6481.384268494486, 6545.770898018546, 6590.670466476753, 6623.801285961429, 6624.238212605612, 6386.393292637192, 6464.41820236181, 6544.574602650812, 6618.338166183343, 6670.7665231716655, 6459.838504037437, 6465.903011454926, 6470.579412338183, 6489.020848641021, 6490.1562796838], "value": 5251.663831821277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.6592143867487, 942.996133216914, 950.0357137505429, 955.4965989108537, 968.1431932739523, 19311.903440482794, 20137.899310503446, 20157.596848063047, 20190.0, 22721.20475783348, 22148.335549933487, 22572.8871355643, 22616.54766904665, 22648.0, 22675.433114172152, 1006.4414250091196, 1025.3898930136556, 1025.6461520775358, 1028.8765348158195, 1029.2435060230762, 1011.5245834457793, 1040.105509262034, 1079.967600971968, 1083.0685610375072, 1087.6573879228017, 1131.383396049151, 1147.8450409194777, 1157.0801213035656, 1157.1437136519, 1157.6179860645966, 1144.9885501144965, 1150.6260465348712, 1153.3368313219933, 1154.0421450196359, 1156.410230782303, 843.7342237195264, 848.4188330993289, 849.9872501912477, 850.0606829453488, 850.4132148817358, 20732.378028659165, 20740.377788666363, 20744.688829667568, 20850.0, 20889.37331880046, 22382.77617223823, 22594.774052259596, 22986.195483158008, 23125.999999999833, 23285.76714232853, 17392.652146957116, 17805.198766055557, 17932.282708691768, 18014.90992545042, 18095.72856407155, 3842.9039274018373, 3862.1310205203886, 3863.826127824255, 3864.516935383077, 3868.4197370394386, 130760.3461982684, 131432.0, 136163.0, 136206.0, 137594.0, 16649.83350166507, 17614.295428182984, 17754.467365979042, 17850.91074544619, 17883.463496095137, 33634.32731345359, 35280.823595881855, 35466.46800297998, 35527.0, 35579.82210088985, 8375.95812020936, 8784.0, 8852.203301702877, 8866.64533418656, 8871.423357481743, 4259.61663450291, 4354.825806967686, 4359.564043595615, 4372.737635741865, 4381.21138195128, 5331.893362132813, 5441.755121019563, 5951.702414879239, 6077.908831367533, 6120.510359171256, 1095.1239008792934, 1124.8200287954053, 1127.182792475465, 1137.8179491281521, 1142.948567314473, 708.0759608710682, 717.519262094398, 717.5802155738951, 730.5288089182447, 741.7292688168887, 12801.10392272532, 13562.389692463863, 13568.525101621395, 13904.86095139056, 14119.64700882486, 649.9512536559682, 664.9534532582769, 669.464428457242, 678.460623804067, 680.5474359550843, 6137.662428566382, 6302.401271879165, 6306.684665766693, 6357.268914074941, 6375.4262116409745, 142609.0, 143313.0, 143939.2803035978, 145388.0, 146379.2681036588, 122062.38968805099, 122512.77487225192, 125623.37188314, 125649.37175314064, 126018.0, 109392.0, 109429.45285273522, 110409.44795276133, 113303.0, 114066.42966785113, 11574.074074074222, 11676.124290678403, 11763.529458821893, 11854.466549005143, 11905.345206013752, 51826.481735183675, 52253.0, 52614.73692631513, 53299.0, 53696.1945570809, 65594.0, 65623.67188164219, 65693.0, 66110.66944665246, 69035.96446053413, 17174.31302747926, 17386.47840564785, 17389.47831565055, 17412.651746965243, 17520.0, 23227.3031809046, 23452.0, 23738.52522949566, 24133.034678612657, 24253.63619545673, 20834.895825520776, 21416.89291553532, 21512.677309840677, 21564.78435215628, 21901.671474928207, 19677.31129410464, 19885.204591816164, 20245.493862652962, 20572.69140962857, 20722.0, 20423.489412764204, 20905.581888362452, 20924.895375523025, 20931.686024709947, 21109.05009274617, 14160.0, 14664.486742963945, 14773.261336933325, 14907.478238261609, 15118.848811511743, 16229.918850406144, 16290.918545407198, 16346.346146154021, 16487.010779353277, 16782.24479898383], "value": 10030.224248954319, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 105.0, 98.0, 106.0, 107.0, 111.0, 108.0, 97.0, 106.0, 108.0], "value": 104.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 136.0, 172.0, 112.0, 137.0, 138.0, 119.0, 164.0, 115.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 165.0, 167.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 186.0, 74.0, 74.0, 73.0, 75.0, 167.0, 74.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 136.0, 77.0, 78.0, 79.0, 135.0, 78.0, 78.0, 130.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 150.0, 149.0, 151.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 48.0, 48.0, 50.0, 50.0, 47.0, 49.0, 47.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 74.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 116.0, 117.0, 116.0, 113.0, 118.0, 130.0, 117.0, 164.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 160.0, 165.0, 164.0, 161.0, 167.0, 172.0, 165.0, 169.0, 179.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 62.0, 60.0, 61.0, 61.0, 63.0, 64.0, 62.0], "value": 61.6, "unit": "score"}]}]} 20:26:03 INFO - Return code: 0 20:26:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:04 INFO - # TBPL SUCCESS # 20:26:04 INFO - Running post-action listener: _package_coverage_data 20:26:04 INFO - Running post-action listener: _resource_record_post_action 20:26:04 INFO - [mozharness: 2017-08-16 03:26:04.045970Z] Finished run-tests step (success) 20:26:04 INFO - Running post-run listener: _resource_record_post_run 20:26:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 5885952; Write bytes: 439619584; Read time: 3140; Write time: 405328 20:26:04 INFO - TinderboxPrint: CPU usage
13.1% 20:26:04 INFO - TinderboxPrint: I/O read bytes / time
5,885,952 / 3,140 20:26:04 INFO - TinderboxPrint: I/O write bytes / time
439,619,584 / 405,328 20:26:04 INFO - TinderboxPrint: CPU idle
8,247.2 (86.9%) 20:26:04 INFO - TinderboxPrint: CPU user
1,188.5 (12.5%) 20:26:04 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 119050240; Read time: 124; Write time: 89332 20:26:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:26:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 3694592; Write bytes: 268836864; Read time: 2592; Write time: 289676 20:26:04 INFO - Running post-run listener: _upload_blobber_files 20:26:04 INFO - Blob upload gear active. 20:26:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:04 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 20:26:04 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'] 20:26:04 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 20:26:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:06 INFO - (blobuploader) - INFO - Done attempting. 20:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:06 INFO - (blobuploader) - INFO - Done attempting. 20:26:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:14 INFO - (blobuploader) - INFO - Done attempting. 20:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:15 INFO - (blobuploader) - INFO - Done attempting. 20:26:15 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:15 INFO - Return code: 0 20:26:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61e7042ddb06a92edd98741cd851cebc7464f65508cf8eafb0e7f2e53974dc6d66a3cf32bbc9b3ec30821266d94a0f03c8e569bc9976ac5756e8bb34e177b28", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa817f324973b4a4ef843b59b21f33a72b0dd4ab8af614b935a80b6ba6fa4d79da8b7d2909441c164d0440b45562843c9620d25629908e3cf452b713ade9c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bce5946b9953cb350e5b4d72d718cd4576b0a34600699bfb2ac2af1aae9b37485bd18381d0e8642497311680af75dd65cc4ce3766f453e14eb0884fe42340f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952c16380d62b925cf5fedb1716c6fef49785444f29a9b3ee59979991cec0c70019cf74a5a4d1f50a1134a88f4e15f0761db11f45356a4785720f18600d2a8f2"} 20:26:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:15 INFO - Contents: 20:26:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61e7042ddb06a92edd98741cd851cebc7464f65508cf8eafb0e7f2e53974dc6d66a3cf32bbc9b3ec30821266d94a0f03c8e569bc9976ac5756e8bb34e177b28", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa817f324973b4a4ef843b59b21f33a72b0dd4ab8af614b935a80b6ba6fa4d79da8b7d2909441c164d0440b45562843c9620d25629908e3cf452b713ade9c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bce5946b9953cb350e5b4d72d718cd4576b0a34600699bfb2ac2af1aae9b37485bd18381d0e8642497311680af75dd65cc4ce3766f453e14eb0884fe42340f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952c16380d62b925cf5fedb1716c6fef49785444f29a9b3ee59979991cec0c70019cf74a5a4d1f50a1134a88f4e15f0761db11f45356a4785720f18600d2a8f2"} 20:26:15 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:15 INFO - Copying logs to upload dir... 20:26:15 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.441437 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-15 20:26:15.192155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:15.195536) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61e7042ddb06a92edd98741cd851cebc7464f65508cf8eafb0e7f2e53974dc6d66a3cf32bbc9b3ec30821266d94a0f03c8e569bc9976ac5756e8bb34e177b28", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa817f324973b4a4ef843b59b21f33a72b0dd4ab8af614b935a80b6ba6fa4d79da8b7d2909441c164d0440b45562843c9620d25629908e3cf452b713ade9c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bce5946b9953cb350e5b4d72d718cd4576b0a34600699bfb2ac2af1aae9b37485bd18381d0e8642497311680af75dd65cc4ce3766f453e14eb0884fe42340f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952c16380d62b925cf5fedb1716c6fef49785444f29a9b3ee59979991cec0c70019cf74a5a4d1f50a1134a88f4e15f0761db11f45356a4785720f18600d2a8f2"} build_url:https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/Grvz1iDjQMWMGsNN5J8IWw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61e7042ddb06a92edd98741cd851cebc7464f65508cf8eafb0e7f2e53974dc6d66a3cf32bbc9b3ec30821266d94a0f03c8e569bc9976ac5756e8bb34e177b28", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa817f324973b4a4ef843b59b21f33a72b0dd4ab8af614b935a80b6ba6fa4d79da8b7d2909441c164d0440b45562843c9620d25629908e3cf452b713ade9c35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11bce5946b9953cb350e5b4d72d718cd4576b0a34600699bfb2ac2af1aae9b37485bd18381d0e8642497311680af75dd65cc4ce3766f453e14eb0884fe42340f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/952c16380d62b925cf5fedb1716c6fef49785444f29a9b3ee59979991cec0c70019cf74a5a4d1f50a1134a88f4e15f0761db11f45356a4785720f18600d2a8f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:15.226582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:15.227018) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1502852660.349596-973652739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:15.311303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:15.312015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:15.312666) ========= ========= Total master_lag: 0.17 =========