builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1502707788.81 results: success (0) revision: df9beb781895fcd0493c21e95ad313e0044515ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:48.813548) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:48.813957) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:48.814237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:48.854294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:48.854548) ========= 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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 03:49:49-- 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% 37.9M=0s 2017-08-14 03:49:49 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191915 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:49.148556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:49.148947) ========= 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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016851 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:49.205064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:49.205451) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev df9beb781895fcd0493c21e95ad313e0044515ec --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 df9beb781895fcd0493c21e95ad313e0044515ec --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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 03:49:49,380 truncating revision to first 12 chars 2017-08-14 03:49:49,380 Setting DEBUG logging. 2017-08-14 03:49:49,380 attempt 1/10 2017-08-14 03:49:49,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/df9beb781895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 03:49:49,827 unpacking tar archive at: mozilla-central-df9beb781895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834519 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:50.068884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:50.069201) ========= script_repo_revision: df9beb781895fcd0493c21e95ad313e0044515ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:50.069896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:50.070175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:49:50.078927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-14 03:49:50.079237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:50 INFO - MultiFileLogger online at 20170814 03:49:50 in /builds/slave/test 03:49:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:49:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:50 INFO - {'append_to_log': False, 03:49:50 INFO - 'base_work_dir': '/builds/slave/test', 03:49:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:49:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:50 INFO - 'branch': 'Firefox-Non-PGO', 03:49:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:50 INFO - 'code_coverage': False, 03:49:50 INFO - 'config_files': ('talos/linux_config.py',), 03:49:50 INFO - 'default_actions': ('clobber', 03:49:50 INFO - 'read-buildbot-config', 03:49:50 INFO - 'download-and-extract', 03:49:50 INFO - 'populate-webroot', 03:49:50 INFO - 'create-virtualenv', 03:49:50 INFO - 'install', 03:49:50 INFO - 'setup-mitmproxy', 03:49:50 INFO - 'run-tests'), 03:49:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:50 INFO - 'disable_ccov_upload': False, 03:49:50 INFO - 'download_minidump_stackwalk': True, 03:49:50 INFO - 'download_symbols': 'ondemand', 03:49:50 INFO - 'enable_stylo': False, 03:49:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:50 INFO - 'gecko_profile': False, 03:49:50 INFO - 'gecko_profile_interval': 0, 03:49:50 INFO - 'installer_path': 'installer.exe', 03:49:50 INFO - 'log_level': 'info', 03:49:50 INFO - 'log_name': 'talos', 03:49:50 INFO - 'log_to_console': True, 03:49:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:50 INFO - 'opt_config_files': (), 03:49:50 INFO - 'pip_index': False, 03:49:50 INFO - 'suite': 'dromaeojs-e10s', 03:49:50 INFO - 'system_bits': '32', 03:49:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:50 INFO - 'title': 'talos-linux64-ix-014', 03:49:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:50 INFO - 'use_talos_json': True, 03:49:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:50 INFO - 'work_dir': 'build'} 03:49:50 INFO - [mozharness: 2017-08-14 10:49:50.450947Z] Running clobber step. 03:49:50 INFO - Running pre-action listener: _resource_record_pre_action 03:49:50 INFO - Running main action method: clobber 03:49:50 INFO - rmtree: /builds/slave/test/build 03:49:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - [mozharness: 2017-08-14 10:49:51.430272Z] Finished clobber step (success) 03:49:51 INFO - [mozharness: 2017-08-14 10:49:51.430375Z] Running read-buildbot-config step. 03:49:51 INFO - Running pre-action listener: _resource_record_pre_action 03:49:51 INFO - Running main action method: read_buildbot_config 03:49:51 INFO - Using buildbot properties: 03:49:51 INFO - { 03:49:51 INFO - "project": "", 03:49:51 INFO - "product": "firefox", 03:49:51 INFO - "who": "archaeopteryx@coole-files.de", 03:49:51 INFO - "installer_path": "public/build/target.tar.bz2", 03:49:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:49:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:49:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:49:51 INFO - "stage_platform": "linux64", 03:49:51 INFO - "basedir": "/builds/slave/test", 03:49:51 INFO - "buildnumber": 1075, 03:49:51 INFO - "platform": "ubuntu64_hw", 03:49:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:49:51 INFO - "slavebuilddir": "test", 03:49:51 INFO - "taskId": "bK3BpV1DTherCTe2PcXL7g", 03:49:51 INFO - "branch": "mozilla-central", 03:49:51 INFO - "script_repo_revision": "production", 03:49:51 INFO - "revision": "df9beb781895fcd0493c21e95ad313e0044515ec", 03:49:51 INFO - "slavename": "talos-linux64-ix-014", 03:49:51 INFO - "repo_path": "mozilla-central" 03:49:51 INFO - } 03:49:51 INFO - Finding installer, test and symbols from parent task. 03:49:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bK3BpV1DTherCTe2PcXL7g'}, attempt #1 03:49:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bK3BpV1DTherCTe2PcXL7g'}, attempt #1 03:49:52 INFO - Task dependencies: a-GT4NhbSgyPIRge8EWYUw 03:49:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw'}, attempt #1 03:49:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:49:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json 03:49:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip 03:49:52 INFO - Running post-action listener: _resource_record_post_action 03:49:52 INFO - [mozharness: 2017-08-14 10:49:52.784897Z] Finished read-buildbot-config step (success) 03:49:52 INFO - [mozharness: 2017-08-14 10:49:52.785118Z] Running download-and-extract step. 03:49:52 INFO - Running pre-action listener: _resource_record_pre_action 03:49:52 INFO - Running main action method: download_and_extract 03:49:52 INFO - mkdir: /builds/slave/test/build/tests 03:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:52 INFO - trying https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json 03:49:52 INFO - Downloading https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:49:53 INFO - Downloaded 989 bytes. 03:49:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:49:53 INFO - Using the following test package requirements: 03:49:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:49:53 INFO - u'common': [u'target.common.tests.zip'], 03:49:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:49:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:49:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:49:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:49:53 INFO - u'mozbase': [u'target.common.tests.zip'], 03:49:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:49:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:49:53 INFO - u'web-platform': [u'target.common.tests.zip', 03:49:53 INFO - u'target.web-platform.tests.tar.gz'], 03:49:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:49:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip 03:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip into memory 03:49:54 INFO - Content-Length response header: 54034603 03:49:54 INFO - Bytes received: 54034603 03:50:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:50:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip 03:50:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:50:05 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip into memory 03:50:06 INFO - Content-Length response header: 54034603 03:50:06 INFO - Bytes received: 54034603 03:50:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip 03:50:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:50:18 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip into memory 03:50:19 INFO - Content-Length response header: 14496050 03:50:19 INFO - Bytes received: 14496050 03:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:19 INFO - trying https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:19 INFO - Downloading https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:50:21 INFO - Downloaded 61800762 bytes. 03:50:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:21 INFO - mkdir: /builds/slave/test/properties 03:50:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:21 INFO - Contents: 03:50:21 INFO - build_url:https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:21 INFO - Running post-action listener: _resource_record_post_action 03:50:21 INFO - Running post-action listener: set_extra_try_arguments 03:50:21 INFO - [mozharness: 2017-08-14 10:50:21.178926Z] Finished download-and-extract step (success) 03:50:21 INFO - [mozharness: 2017-08-14 10:50:21.179024Z] Running populate-webroot step. 03:50:21 INFO - Running pre-action listener: _resource_record_pre_action 03:50:21 INFO - Running main action method: populate_webroot 03:50:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:50:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:50:21 INFO - 'tests': ['damp', 'tps']}, 03:50:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:50:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:50:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:50:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:21 INFO - 'ts_paint', 03:50:21 INFO - 'tpaint', 03:50:21 INFO - 'sessionrestore', 03:50:21 INFO - 'sessionrestore_many_windows', 03:50:21 INFO - 'sessionrestore_no_auto_restore', 03:50:21 INFO - 'tabpaint']}, 03:50:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:50:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:50:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:21 INFO - 'tsvgr_opacity', 03:50:21 INFO - 'tart', 03:50:21 INFO - 'tscrollx', 03:50:21 INFO - 'tsvg_static']}, 03:50:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:50:21 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:21 INFO - 'talos_options': ['--mitmproxy', 03:50:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:21 INFO - '--firstNonBlankPaint'], 03:50:21 INFO - 'tests': ['tp6_google', 03:50:21 INFO - 'tp6_youtube', 03:50:21 INFO - 'tp6_amazon', 03:50:21 INFO - 'tp6_facebook']}, 03:50:21 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:21 INFO - 'talos_options': ['--stylo', 03:50:21 INFO - '--mitmproxy', 03:50:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:21 INFO - '--firstNonBlankPaint'], 03:50:21 INFO - 'tests': ['tp6_google', 03:50:21 INFO - 'tp6_youtube', 03:50:21 INFO - 'tp6_amazon', 03:50:21 INFO - 'tp6_facebook']}, 03:50:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:21 INFO - 'talos_options': ['--stylo', 03:50:21 INFO - '--stylo-threads=1', 03:50:21 INFO - '--mitmproxy', 03:50:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:21 INFO - '--firstNonBlankPaint'], 03:50:21 INFO - 'tests': ['tp6_google', 03:50:21 INFO - 'tp6_youtube', 03:50:21 INFO - 'tp6_amazon', 03:50:21 INFO - 'tp6_facebook']}, 03:50:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:50:21 INFO - 'talos_options': ['--xperf_path', 03:50:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:21 INFO - 'tests': ['tp5n']}}} 03:50:21 INFO - Running post-action listener: _resource_record_post_action 03:50:21 INFO - [mozharness: 2017-08-14 10:50:21.187481Z] Finished populate-webroot step (success) 03:50:21 INFO - [mozharness: 2017-08-14 10:50:21.187571Z] Running create-virtualenv step. 03:50:21 INFO - Running pre-action listener: _resource_record_pre_action 03:50:21 INFO - Running main action method: create_virtualenv 03:50:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:50:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:50:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:21 INFO - Using real prefix '/usr' 03:50:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:23 INFO - Installing pip.................done. 03:50:23 INFO - Return code: 0 03:50:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:50:24 INFO - Reading from file tmpfile_stdout 03:50:24 INFO - Output received: 03:50:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:50:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:24 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:24 INFO - Using env: {'DISPLAY': ':0', 03:50:24 INFO - 'HOME': '/home/cltbld', 03:50:24 INFO - 'LANG': 'en_US.UTF-8', 03:50:24 INFO - 'LANGUAGE': 'en_US:en', 03:50:24 INFO - 'LOGNAME': 'cltbld', 03:50:24 INFO - 'MAIL': '/var/mail/cltbld', 03:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:24 INFO - 'MOZ_NO_REMOTE': '1', 03:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:24 INFO - 'NO_EM_RESTART': '1', 03:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:24 INFO - 'PWD': '/builds/slave/test', 03:50:24 INFO - 'SHELL': '/bin/bash', 03:50:24 INFO - 'SHLVL': '1', 03:50:24 INFO - 'TERM': 'linux', 03:50:24 INFO - 'TMOUT': '86400', 03:50:24 INFO - 'USER': 'cltbld', 03:50:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:24 INFO - '_': '/tools/buildbot/bin/python'} 03:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:50:24 INFO - Cleaning up... 03:50:24 INFO - Return code: 0 03:50:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:24 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:50:24 INFO - Using env: {'DISPLAY': ':0', 03:50:24 INFO - 'HOME': '/home/cltbld', 03:50:24 INFO - 'LANG': 'en_US.UTF-8', 03:50:24 INFO - 'LANGUAGE': 'en_US:en', 03:50:24 INFO - 'LOGNAME': 'cltbld', 03:50:24 INFO - 'MAIL': '/var/mail/cltbld', 03:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:24 INFO - 'MOZ_NO_REMOTE': '1', 03:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:24 INFO - 'NO_EM_RESTART': '1', 03:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:24 INFO - 'PWD': '/builds/slave/test', 03:50:24 INFO - 'SHELL': '/bin/bash', 03:50:24 INFO - 'SHLVL': '1', 03:50:24 INFO - 'TERM': 'linux', 03:50:24 INFO - 'TMOUT': '86400', 03:50:24 INFO - 'USER': 'cltbld', 03:50:24 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:24 INFO - '_': '/tools/buildbot/bin/python'} 03:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:24 INFO - Downloading/unpacking psutil>=3.1.1 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:25 INFO - Installing collected packages: psutil 03:50:25 INFO - Running setup.py install for psutil 03:50:25 INFO - building 'psutil._psutil_linux' extension 03:50:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:50:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:50:26 INFO - building 'psutil._psutil_posix' extension 03:50:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:50:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:50:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:27 INFO - Successfully installed psutil 03:50:27 INFO - Cleaning up... 03:50:27 INFO - Return code: 0 03:50:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:27 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:50:27 INFO - Using env: {'DISPLAY': ':0', 03:50:27 INFO - 'HOME': '/home/cltbld', 03:50:27 INFO - 'LANG': 'en_US.UTF-8', 03:50:27 INFO - 'LANGUAGE': 'en_US:en', 03:50:27 INFO - 'LOGNAME': 'cltbld', 03:50:27 INFO - 'MAIL': '/var/mail/cltbld', 03:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:27 INFO - 'MOZ_NO_REMOTE': '1', 03:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:27 INFO - 'NO_EM_RESTART': '1', 03:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:27 INFO - 'PWD': '/builds/slave/test', 03:50:27 INFO - 'SHELL': '/bin/bash', 03:50:27 INFO - 'SHLVL': '1', 03:50:27 INFO - 'TERM': 'linux', 03:50:27 INFO - 'TMOUT': '86400', 03:50:27 INFO - 'USER': 'cltbld', 03:50:27 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:27 INFO - '_': '/tools/buildbot/bin/python'} 03:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:28 INFO - Installing collected packages: mozsystemmonitor 03:50:28 INFO - Running setup.py install for mozsystemmonitor 03:50:28 INFO - Successfully installed mozsystemmonitor 03:50:28 INFO - Cleaning up... 03:50:28 INFO - Return code: 0 03:50:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:50:28 INFO - Using env: {'DISPLAY': ':0', 03:50:28 INFO - 'HOME': '/home/cltbld', 03:50:28 INFO - 'LANG': 'en_US.UTF-8', 03:50:28 INFO - 'LANGUAGE': 'en_US:en', 03:50:28 INFO - 'LOGNAME': 'cltbld', 03:50:28 INFO - 'MAIL': '/var/mail/cltbld', 03:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:28 INFO - 'MOZ_NO_REMOTE': '1', 03:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:28 INFO - 'NO_EM_RESTART': '1', 03:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:28 INFO - 'PWD': '/builds/slave/test', 03:50:28 INFO - 'SHELL': '/bin/bash', 03:50:28 INFO - 'SHLVL': '1', 03:50:28 INFO - 'TERM': 'linux', 03:50:28 INFO - 'TMOUT': '86400', 03:50:28 INFO - 'USER': 'cltbld', 03:50:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:28 INFO - '_': '/tools/buildbot/bin/python'} 03:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:30 INFO - warning: no files found matching '*.txt' 03:50:30 INFO - no previously-included directories found matching 'build' 03:50:30 INFO - no previously-included directories found matching 'dist' 03:50:30 INFO - no previously-included directories found matching '.git*' 03:50:30 INFO - Installing collected packages: jsonschema, functools32 03:50:30 INFO - Running setup.py install for functools32 03:50:30 INFO - warning: no files found matching '*.txt' 03:50:30 INFO - no previously-included directories found matching 'build' 03:50:30 INFO - no previously-included directories found matching 'dist' 03:50:30 INFO - no previously-included directories found matching '.git*' 03:50:30 INFO - Successfully installed jsonschema functools32 03:50:30 INFO - Cleaning up... 03:50:30 INFO - Return code: 0 03:50:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:30 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:50:30 INFO - Using env: {'DISPLAY': ':0', 03:50:30 INFO - 'HOME': '/home/cltbld', 03:50:30 INFO - 'LANG': 'en_US.UTF-8', 03:50:30 INFO - 'LANGUAGE': 'en_US:en', 03:50:30 INFO - 'LOGNAME': 'cltbld', 03:50:30 INFO - 'MAIL': '/var/mail/cltbld', 03:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:30 INFO - 'MOZ_NO_REMOTE': '1', 03:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:30 INFO - 'NO_EM_RESTART': '1', 03:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:30 INFO - 'PWD': '/builds/slave/test', 03:50:30 INFO - 'SHELL': '/bin/bash', 03:50:30 INFO - 'SHLVL': '1', 03:50:30 INFO - 'TERM': 'linux', 03:50:30 INFO - 'TMOUT': '86400', 03:50:30 INFO - 'USER': 'cltbld', 03:50:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:30 INFO - '_': '/tools/buildbot/bin/python'} 03:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:30 INFO - Cleaning up... 03:50:30 INFO - Return code: 0 03:50:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:30 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:50:30 INFO - Using env: {'DISPLAY': ':0', 03:50:30 INFO - 'HOME': '/home/cltbld', 03:50:30 INFO - 'LANG': 'en_US.UTF-8', 03:50:30 INFO - 'LANGUAGE': 'en_US:en', 03:50:30 INFO - 'LOGNAME': 'cltbld', 03:50:30 INFO - 'MAIL': '/var/mail/cltbld', 03:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:30 INFO - 'MOZ_NO_REMOTE': '1', 03:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:30 INFO - 'NO_EM_RESTART': '1', 03:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:30 INFO - 'PWD': '/builds/slave/test', 03:50:30 INFO - 'SHELL': '/bin/bash', 03:50:30 INFO - 'SHLVL': '1', 03:50:30 INFO - 'TERM': 'linux', 03:50:30 INFO - 'TMOUT': '86400', 03:50:30 INFO - 'USER': 'cltbld', 03:50:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:30 INFO - '_': '/tools/buildbot/bin/python'} 03:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - Downloading docopt-0.6.1.tar.gz 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:32 INFO - Running setup.py install for blobuploader 03:50:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:32 INFO - Running setup.py install for requests 03:50:33 INFO - Running setup.py install for docopt 03:50:33 INFO - Successfully installed blobuploader requests docopt 03:50:33 INFO - Cleaning up... 03:50:33 INFO - Return code: 0 03:50:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:33 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:33 INFO - Using env: {'DISPLAY': ':0', 03:50:33 INFO - 'HOME': '/home/cltbld', 03:50:33 INFO - 'LANG': 'en_US.UTF-8', 03:50:33 INFO - 'LANGUAGE': 'en_US:en', 03:50:33 INFO - 'LOGNAME': 'cltbld', 03:50:33 INFO - 'MAIL': '/var/mail/cltbld', 03:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:33 INFO - 'MOZ_NO_REMOTE': '1', 03:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:33 INFO - 'NO_EM_RESTART': '1', 03:50:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:33 INFO - 'PWD': '/builds/slave/test', 03:50:33 INFO - 'SHELL': '/bin/bash', 03:50:33 INFO - 'SHLVL': '1', 03:50:33 INFO - 'TERM': 'linux', 03:50:33 INFO - 'TMOUT': '86400', 03:50:33 INFO - 'USER': 'cltbld', 03:50:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:33 INFO - '_': '/tools/buildbot/bin/python'} 03:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:33 INFO - Running setup.py (path:/tmp/pip-IVYJ0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:33 INFO - Running setup.py (path:/tmp/pip-XxY2eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:33 INFO - Running setup.py (path:/tmp/pip-YvV4iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:33 INFO - Running setup.py (path:/tmp/pip-2SYEtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:33 INFO - Running setup.py (path:/tmp/pip-oPs4fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:33 INFO - Running setup.py (path:/tmp/pip-yCN2Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:33 INFO - Running setup.py (path:/tmp/pip-7b5aTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:33 INFO - Running setup.py (path:/tmp/pip-oQRh6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:33 INFO - Running setup.py (path:/tmp/pip-ok4UGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:34 INFO - Running setup.py (path:/tmp/pip-hwHDGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:34 INFO - Running setup.py (path:/tmp/pip-X3iLe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:34 INFO - Running setup.py (path:/tmp/pip-cYJVuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:34 INFO - Running setup.py (path:/tmp/pip-nhhLJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:34 INFO - Running setup.py (path:/tmp/pip-vgpopx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Running setup.py (path:/tmp/pip-JXSArR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:34 INFO - Running setup.py (path:/tmp/pip-LYXWPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:34 INFO - Running setup.py (path:/tmp/pip-WWUJaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:34 INFO - Running setup.py install for manifestparser 03:50:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:34 INFO - Running setup.py install for mozcrash 03:50:34 INFO - Running setup.py install for mozdebug 03:50:34 INFO - Running setup.py install for mozdevice 03:50:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozfile 03:50:35 INFO - Running setup.py install for mozhttpd 03:50:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozinfo 03:50:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozInstall 03:50:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozleak 03:50:35 INFO - Running setup.py install for mozlog 03:50:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for moznetwork 03:50:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozprocess 03:50:35 INFO - Running setup.py install for mozprofile 03:50:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:35 INFO - Running setup.py install for mozrunner 03:50:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozscreenshot 03:50:36 INFO - Running setup.py install for moztest 03:50:36 INFO - Running setup.py install for mozversion 03:50:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:36 INFO - Cleaning up... 03:50:36 INFO - Return code: 0 03:50:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:36 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:36 INFO - Using env: {'DISPLAY': ':0', 03:50:36 INFO - 'HOME': '/home/cltbld', 03:50:36 INFO - 'LANG': 'en_US.UTF-8', 03:50:36 INFO - 'LANGUAGE': 'en_US:en', 03:50:36 INFO - 'LOGNAME': 'cltbld', 03:50:36 INFO - 'MAIL': '/var/mail/cltbld', 03:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:36 INFO - 'MOZ_NO_REMOTE': '1', 03:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:36 INFO - 'NO_EM_RESTART': '1', 03:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:36 INFO - 'PWD': '/builds/slave/test', 03:50:36 INFO - 'SHELL': '/bin/bash', 03:50:36 INFO - 'SHLVL': '1', 03:50:36 INFO - 'TERM': 'linux', 03:50:36 INFO - 'TMOUT': '86400', 03:50:36 INFO - 'USER': 'cltbld', 03:50:36 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:36 INFO - '_': '/tools/buildbot/bin/python'} 03:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:36 INFO - Running setup.py (path:/tmp/pip-XMV7ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:36 INFO - Running setup.py (path:/tmp/pip-prbtoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:36 INFO - Running setup.py (path:/tmp/pip-1d8Ac8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:36 INFO - Running setup.py (path:/tmp/pip-nBnQ1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:36 INFO - Running setup.py (path:/tmp/pip-TQatBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:36 INFO - Running setup.py (path:/tmp/pip-T3Q8UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:37 INFO - Running setup.py (path:/tmp/pip-Y6nWMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:37 INFO - Running setup.py (path:/tmp/pip-6UZSpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:37 INFO - Running setup.py (path:/tmp/pip-fzmPUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:37 INFO - Running setup.py (path:/tmp/pip-dqIJhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:37 INFO - Running setup.py (path:/tmp/pip-e44ou8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:37 INFO - Running setup.py (path:/tmp/pip-aM6cNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:37 INFO - Running setup.py (path:/tmp/pip-94wGSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:37 INFO - Running setup.py (path:/tmp/pip-LUapv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:37 INFO - Running setup.py (path:/tmp/pip-6G2uJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:37 INFO - Running setup.py (path:/tmp/pip-mLOeP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:37 INFO - Running setup.py (path:/tmp/pip-E9sJ4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:38 INFO - Downloading blessings-1.6.tar.gz 03:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:39 INFO - Installing collected packages: blessings 03:50:39 INFO - Running setup.py install for blessings 03:50:39 INFO - Successfully installed blessings 03:50:39 INFO - Cleaning up... 03:50:39 INFO - Return code: 0 03:50:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:39 INFO - Reading from file tmpfile_stdout 03:50:39 INFO - Current package versions: 03:50:39 INFO - argparse == 1.2.1 03:50:39 INFO - blessings == 1.6 03:50:39 INFO - blobuploader == 1.2.4 03:50:39 INFO - docopt == 0.6.1 03:50:39 INFO - functools32 == 3.2.3-2 03:50:39 INFO - jsonschema == 2.5.1 03:50:39 INFO - manifestparser == 1.1 03:50:39 INFO - mozInstall == 1.13 03:50:39 INFO - mozcrash == 1.0 03:50:39 INFO - mozdebug == 0.1 03:50:39 INFO - mozdevice == 0.51 03:50:39 INFO - mozfile == 1.2 03:50:39 INFO - mozhttpd == 0.7 03:50:39 INFO - mozinfo == 0.10 03:50:39 INFO - mozleak == 0.1 03:50:39 INFO - mozlog == 3.5 03:50:39 INFO - moznetwork == 0.27 03:50:39 INFO - mozprocess == 0.25 03:50:39 INFO - mozprofile == 0.28 03:50:39 INFO - mozrunner == 6.13 03:50:39 INFO - mozscreenshot == 0.1 03:50:39 INFO - mozsystemmonitor == 0.3 03:50:39 INFO - moztest == 0.8 03:50:39 INFO - mozversion == 1.4 03:50:39 INFO - psutil == 3.1.1 03:50:39 INFO - requests == 1.2.3 03:50:39 INFO - wsgiref == 0.1.2 03:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:39 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:39 INFO - Using env: {'DISPLAY': ':0', 03:50:39 INFO - 'HOME': '/home/cltbld', 03:50:39 INFO - 'LANG': 'en_US.UTF-8', 03:50:39 INFO - 'LANGUAGE': 'en_US:en', 03:50:39 INFO - 'LOGNAME': 'cltbld', 03:50:39 INFO - 'MAIL': '/var/mail/cltbld', 03:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:39 INFO - 'MOZ_NO_REMOTE': '1', 03:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:39 INFO - 'NO_EM_RESTART': '1', 03:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:39 INFO - 'PWD': '/builds/slave/test', 03:50:39 INFO - 'SHELL': '/bin/bash', 03:50:39 INFO - 'SHLVL': '1', 03:50:39 INFO - 'TERM': 'linux', 03:50:39 INFO - 'TMOUT': '86400', 03:50:39 INFO - 'USER': 'cltbld', 03:50:39 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:39 INFO - '_': '/tools/buildbot/bin/python'} 03:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:50:39 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:40 INFO - Installing collected packages: simplejson 03:50:40 INFO - Running setup.py install for simplejson 03:50:40 INFO - building 'simplejson._speedups' extension 03:50:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:50:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:50:41 INFO - Successfully installed simplejson 03:50:41 INFO - Cleaning up... 03:50:41 INFO - Return code: 0 03:50:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:41 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 0xf881f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1155a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, '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': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:50:41 INFO - Using env: {'DISPLAY': ':0', 03:50:41 INFO - 'HOME': '/home/cltbld', 03:50:41 INFO - 'LANG': 'en_US.UTF-8', 03:50:41 INFO - 'LANGUAGE': 'en_US:en', 03:50:41 INFO - 'LOGNAME': 'cltbld', 03:50:41 INFO - 'MAIL': '/var/mail/cltbld', 03:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:41 INFO - 'MOZ_NO_REMOTE': '1', 03:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:41 INFO - 'NO_EM_RESTART': '1', 03:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:41 INFO - 'PWD': '/builds/slave/test', 03:50:41 INFO - 'SHELL': '/bin/bash', 03:50:41 INFO - 'SHLVL': '1', 03:50:41 INFO - 'TERM': 'linux', 03:50:41 INFO - 'TMOUT': '86400', 03:50:41 INFO - 'USER': 'cltbld', 03:50:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:41 INFO - '_': '/tools/buildbot/bin/python'} 03:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:42 INFO - Cleaning up... 03:50:42 INFO - Return code: 0 03:50:42 INFO - Running post-action listener: _resource_record_post_action 03:50:42 INFO - Running post-action listener: _start_resource_monitoring 03:50:42 INFO - Starting resource monitoring. 03:50:42 INFO - [mozharness: 2017-08-14 10:50:42.172267Z] Finished create-virtualenv step (success) 03:50:42 INFO - [mozharness: 2017-08-14 10:50:42.173225Z] Running install step. 03:50:42 INFO - Running pre-action listener: _resource_record_pre_action 03:50:42 INFO - Running main action method: install 03:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:42 INFO - Reading from file tmpfile_stdout 03:50:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:42 INFO - Reading from file tmpfile_stdout 03:50:42 INFO - Output received: 03:50:42 INFO - Usage: mozinstall [options] installer 03:50:42 INFO - Options: 03:50:42 INFO - -h, --help show this help message and exit 03:50:42 INFO - -d DEST, --destination=DEST 03:50:42 INFO - Directory to install application into. [default: 03:50:42 INFO - "/builds/slave/test"] 03:50:42 INFO - --app=APP Application being installed. [default: firefox] 03:50:42 INFO - mkdir: /builds/slave/test/build/application 03:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:51:00 INFO - Reading from file tmpfile_stdout 03:51:00 INFO - Output received: 03:51:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:00 INFO - Running post-action listener: _resource_record_post_action 03:51:00 INFO - [mozharness: 2017-08-14 10:51:00.440442Z] Finished install step (success) 03:51:00 INFO - [mozharness: 2017-08-14 10:51:00.440699Z] Running setup-mitmproxy step. 03:51:00 INFO - Running pre-action listener: _resource_record_pre_action 03:51:00 INFO - Running main action method: setup_mitmproxy 03:51:00 INFO - Skipping: mitmproxy is not required 03:51:00 INFO - Running post-action listener: _resource_record_post_action 03:51:00 INFO - [mozharness: 2017-08-14 10:51:00.441966Z] Finished setup-mitmproxy step (success) 03:51:00 INFO - [mozharness: 2017-08-14 10:51:00.442186Z] Running run-tests step. 03:51:00 INFO - Running pre-action listener: _resource_record_pre_action 03:51:00 INFO - Running pre-action listener: _set_gcov_prefix 03:51:00 INFO - Running main action method: run_tests 03:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:00 INFO - Python 2.7.3 03:51:00 INFO - Return code: 0 03:51:00 INFO - grabbing minidump binary from tooltool 03:51: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')]} 03:51:00 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 0x12f9f00>, '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 0x12f4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12f5050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:51:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:51:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:51:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:00 INFO - Return code: 0 03:51:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:00 INFO - ENV: RUST_BACKTRACE is now full 03:51:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:51:00 INFO - Using env: {'DISPLAY': ':0', 03:51:00 INFO - 'HOME': '/home/cltbld', 03:51:00 INFO - 'LANG': 'en_US.UTF-8', 03:51:00 INFO - 'LANGUAGE': 'en_US:en', 03:51:00 INFO - 'LOGNAME': 'cltbld', 03:51:00 INFO - 'MAIL': '/var/mail/cltbld', 03:51:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:00 INFO - 'MOZ_NO_REMOTE': '1', 03:51:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:00 INFO - 'NO_EM_RESTART': '1', 03:51:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:00 INFO - 'PWD': '/builds/slave/test', 03:51:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:00 INFO - 'RUST_BACKTRACE': 'full', 03:51:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:00 INFO - 'SHELL': '/bin/bash', 03:51:00 INFO - 'SHLVL': '1', 03:51:00 INFO - 'TERM': 'linux', 03:51:00 INFO - 'TMOUT': '86400', 03:51:00 INFO - 'USER': 'cltbld', 03:51:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806', 03:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:00 INFO - '_': '/tools/buildbot/bin/python'} 03:51:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:51:01 INFO - mozversion application_buildid: 20170814095736 03:51:01 INFO - mozversion application_changeset: df9beb781895fcd0493c21e95ad313e0044515ec 03:51:01 INFO - mozversion application_display_name: Nightly 03:51:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:01 INFO - mozversion application_name: Firefox 03:51:01 INFO - mozversion application_remotingname: firefox 03:51:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:51:01 INFO - mozversion application_vendor: Mozilla 03:51:01 INFO - mozversion application_version: 57.0a1 03:51:01 INFO - mozversion platform_buildid: 20170814095736 03:51:01 INFO - mozversion platform_changeset: df9beb781895fcd0493c21e95ad313e0044515ec 03:51:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:51:01 INFO - mozversion platform_version: 57.0a1 03:51:01 INFO - using testdate: 1502707861 03:51:01 INFO - actual date: 1502707861 03:51:01 INFO - starting webserver on 'localhost:41400' 03:51:01 INFO - SUITE-START | Running 2 tests 03:51:01 INFO - TEST-START | dromaeo_css 03:51:01 INFO - Initialising browser for dromaeo_css test... 03:51:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41400/getInfo.html -profile /tmp/tmptZQc2g/profile 03:51:01 INFO - TEST-INFO | started process 3380 (/builds/slave/test/build/application/firefox/firefox http://localhost:41400/getInfo.html) 03:51:08 INFO - TEST-INFO | 3380: exit 0 03:51:08 INFO - Browser initialized. 03:51:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:08 INFO - TEST-INFO | started process 3592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptZQc2g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:09 INFO - PID 3592 | 03:51:09 INFO - PID 3592 | (/builds/slave/test/build/application/firefox/firefox:3640): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:09 INFO - PID 3592 | 03:51:19 INFO - PID 3592 | RSS: Main: 168353792 03:51:19 INFO - PID 3592 | 03:54:19 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41400/tests/dromaeo/cssquery-ext.html) 03:54:20 INFO - PID 3592 | RSS: Main: 172322816 03:54:20 INFO - PID 3592 | 03:57:22 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-ext.html (next: http://localhost:41400/tests/dromaeo/cssquery-jquery.html) 03:57:22 INFO - PID 3592 | RSS: Main: 170123264 03:57:22 INFO - PID 3592 | 04:00:24 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41400/tests/dromaeo/cssquery-mootools.html) 04:00:25 INFO - PID 3592 | RSS: Main: 171769856 04:00:25 INFO - PID 3592 | 04:03:27 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41400/tests/dromaeo/cssquery-prototype.html) 04:03:27 INFO - PID 3592 | RSS: Main: 170332160 04:03:27 INFO - PID 3592 | 04:06:31 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41400/tests/dromaeo/cssquery-yui.html) 04:06:32 INFO - PID 3592 | RSS: Main: 173912064 04:06:32 INFO - PID 3592 | 04:09:33 INFO - PID 3592 | Cycle 1(1): loaded http://localhost:41400/tests/dromaeo/cssquery-yui.html (next: http://localhost:41400/tests/dromaeo/cssquery-dojo.html) 04:09:34 INFO - PID 3592 | RSS: Main: 174116864 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | __start_tp_report 04:09:34 INFO - PID 3592 | _x_x_mozilla_page_load 04:09:34 INFO - PID 3592 | _x_x_mozilla_page_load_details 04:09:34 INFO - PID 3592 | |i|pagename|runs| 04:09:34 INFO - PID 3592 | |0;dojo.html;3110.9688903110964;3151.070434221903;3185.936281274374;3198.2963747975446;3214.1964508872784;6093.177421048163;6139.600925939811;6214.316425193225;6238.875222495547;6275.466585340251;6202.3487533808975;6216.595921265114;6265.718042688079;6277;6312;5472.835814925539;5658.91511627326;5736.971315143418;5746.655200687951;5787.884242315151;5667.4615911488345;5751.856203594902;5755.827325180251;5762.135679648044;5769.798057068004;5648.096304591266;5666.914996275059;5732.254806875121;5735.2544169257935;5757.596968212227;5481.342238931314;5628.155776633497;5652.434756524356;5719.370869204384;5719.857003574903;5580.665160090408;5583.497485226349;5596.3284405871145;5632.352279487829;5688.459596338341;6156.076588511714;6166.506679465677;6167.7532898684;6174.7530098796;6188.381161883775;6643.667816609151;6644.568103073333;6686.297938716413;6730.528862979593;6735.461163106939;6593.703283352261;6690.59856408617;6700.798976030727;6707.228668703064;6812.182538095411;6179.84550386244;6198.566100372931;6215.502759779207;6224.719887605114;6272.968635156886;6720.630365329856;6724.058631791553;6834.794956151323;6932.688029038705;6960.129983752031;6472.223333200046;6511.706973186218;6546.214454265519;6547.247066587308;6663.06717059612;6620.040094186316;6680;6706.865862682816;6714.563553369016;6717.832054198684;6604.702788374535;6613.900791488131;6671.366220209073;6678.632675202911;6705.765298214539;6434.806955791334;6555.80332590023;6579.210494740566;6579.703913323912;6612.801615951529;5352.598555108382;5355.250264962909;5358.839234822962;5359.383670877821;5366.302380690563;4555.567221113989;4617.58441740245;4643.86068417948;4684;4686;5712.828615141552;5781.219535362757;5797.594168408255;5800.1589769484035;5809.82570522885;6627.1716035495565;6636.402723754885;6705.798826035129;6729.629870357177;6735.225449073321;5633;5690.5447564194765;5702.7433765480655;5721.170430287585;5753.712314384264;5918.585699001114;5926.140709597084;5929.318128415288;5939.287285525765;5941.405859414024;6451;6526;6532.6733663316645;6537.444317232993;6547.476201903932;6670.066190733398;6688.4983626229205;6757.729690812313;6773.288804675635;6774.085498457645;6265.154204182377;6342.841428964312;6425.1968503937005;6439.774607888701;6448.967755161194;6567.408933196035;6604.768833091011;6623.470122390101;6628.734850606114;6630.939049752016;6715.160604924385;6734.966325168343;6742.089817874524;6760.222574404006;6821.386075253251;6453.903191452038;6488.902666459912;6546.18172728409;6559.770408035887;6561.114249576246;6319.936800631935;6417.101605775102;6436.195475565554;6460.549590174107;6554.311797261219;6421.293657697743;6427.485801135805;6432.2602900667025;6435.324290949383;6447.903281450688;6440.25937017249;6483.157189565326;6587.440067594308;6590.637514936724;6597;6233.781817636361;6253.7185826637;6272.09054687077;6282.528810339151;6323.494120470259 04:09:34 INFO - PID 3592 | |1;ext.html;854.4189950833431;881.709036018114;906.7778394293397;1164.9475773590182;1194.5639841457871;32090.679093209063;39640.80179599105;40310.1937961241;43643.78178109113;43760.78119609405;43652.56347436525;44008.3398749019;44105.11789764203;44147.337789933175;44304;7612.657430415617;7643.388528917687;7781.027371578552;7792.493487923295;7802.024746906637;7618.428617853656;7697.807554811118;7700.537967721926;7702.114256860449;7716.112647045577;7718.189590093044;7771.3782897368355;7776.222377762235;7778.299953004229;7780.533168009909;7720.729774457923;7721.150673425918;7762.45662803604;7767.650455729506;7768.456208065438;7593.240675932418;7623.771286861403;7642.159362470124;7669.38644908406;7677.961610191914;39463.60536394657;39679.8016009921;39736.20527589432;39825.20349593021;39837.601623983675;3506.50908872758;3558.982205088984;3566.6789988901123;3568.4825700273573;3568.982155089208;32801.17997050069;33225.501617475755;33303.3339333212;33478.497822532685;33510;4713.128071306819;4960.107180707471;4966.751662416901;4993.0263598598285;4998.150314446553;199192;199565;200690;201149;202392;49912;50347;50389.49610503848;50405.24392134121;50437.747811260706;52601.210981835306;52639.21041184385;52760.47239527632;52853;52883.735581321846;15302.158381289137;16561.17194140288;16971.74542381865;16976;16980.150992450574;12809;13927.582172534638;14179.078359906573;14215.786763198561;14241.074330168505;15002.849971500145;15071;15099.849001509845;15099.849001510063;15206.543803685907;5917.112433134978;5997.790077347272;6029.939700602938;6038.184845045863;6079.75680972765;984.1536278800226;1006.4866917871938;1027.4605831938293;1032.6024480575034;1033.9121174700085;23477.88261058684;23592.88203558971;23598.17406390768;23707.644385334235;23759.643605345933;1120.7646394257297;1134.2457265918072;1143.2283208834003;1145.9369734664674;1148.7300484386162;12624.747505049847;12697.873021269668;12801.231926084465;16232.675346493004;16246;246019;246600;247528;247657;248321;60119;60466.39533604607;60514;60531.69734151301;60585.69707151436;1469.1846025455761;1474.6165996840684;1498.2958009735407;1503.2934520775218;1510.1165817996596;26987.05545305905;27126.321841954108;27296.727032729417;27362.726372736815;27676.58485122765;38572.6142738569;38962.610373897034;39037.41443878287;39045;39082.2183556333;210788;210873;211574;212090;212413;31171.532427014066;31642.841785790923;33402.16494587558;33710.49434258439;34697.653023470455;44744.55255447404;44760.552394475635;44858;44998;45007.77496112498;32649;32663.836680817396;32697.836510817295;32741.34517309688;33666.32667346689;32127;32625.510617341235;32838.671613283565;32953.67046329506;33457.665423345454;35148.29703405969;35658.28683426369;35681.64318356783;35752.284954300245;35806.46290305595;31430.371392572477;31473.370532589677;31575.526367104972;31789;31909.68090319067;23114.537709245385;23178.536429270982;23385.41536461602;23708.52582948297;23743.52512949766 04:09:34 INFO - PID 3592 | |2;jquery.html;562.3465820336713;570.9229254050701;573.4494884910486;581.8865321262352;586.4516676907092;23011.884940575295;23758.40603984899;23831;23840.523189536198;23854.403639908967;21822.89088554559;22622.54754904901;23568.88215558924;23670.93480793364;23779;6468.773592924261;6646.767363142291;6647.8338041549105;6648.966755166218;6653.2681405045405;6294.937050629504;6454.935450645504;6508.707108180143;6514.055461958013;6554.016897465371;6532.281449040602;6532.771353002646;6533.248676402203;6537.967310163466;6538.901916471256;6518.511111666644;6521.804345869631;6523.217213934358;6537.084808126866;6544.901826472606;6065.150878876961;6070.180525629028;6071.696415179267;6077.7568897244055;6083.7870674526175;29798.40403191924;30001.249968750955;30601.846990765127;31075.378492430253;31200;2001.269536619138;2011.6580181369202;2034.8982550872397;2035.0435295411132;2037.0324096054403;19714.80285197144;20260.392188234375;21162;21171.364859054254;21203.46991325229;2422.733499315074;2457.6682147909983;2491.95016099677;2502.06172685243;2507.2728908616477;152310;160256;160257.19871400567;160347.1982640091;160676.19661901615;14978.844004470675;15241.847581524265;15277.694446111016;15756.68486630284;15795.840831833679;23591.29226123219;23706.170284039978;23754.287371378887;23798.64302035471;23846.642300365507;10625.203109766799;10646.574137034588;10719.19606029551;10900.1279897608;10960.506777195045;10136.493175341204;10189.898101019044;10222.539985700661;10283.125934295518;10391;9213.894332680122;9326.347155699035;9379.343445958853;9539.713808585753;9735.734354533864;2648.1525911708454;2714.3349879279704;2721.931951701223;2750.2161883863005;2878.2372671242138;957.368137029571;983.8524221366853;1004.7488127968008;1004.9899501004896;1022.5449674894601;19370.612587748165;19614.497759056154;19616.3134290302;19796.109175087156;20045;1049.900259475364;1059.8728152621734;1065.4566171252718;1071.7427817323942;1072.6406653770919;10831.566737330419;13251.867481325256;13554.661133471742;14126.011179217356;14403.78394324086;527439;531776;541996;547034;556365;122962.38518807528;124504.37747811203;124692.37653811673;124846.37576812058;129502;1268.9428975696117;1281.9743605128033;1322.907396482237;1326.9270190139441;1329.3951252180427;20311.59376812485;20931.476713082295;20937.26719564808;20953.89523052375;21261.46846328854;57379;58029;58555.4144458567;60714.696426517585;62066.37933620606;72658;73388;73778;74139;75184.62407687926;14331.713365732418;14547.199904005382;14550.636234094232;14565.417383304974;14696.485623003144;23425.297241082793;23551;23628.88185559061;23674.88162559245;23694;18326.725099123258;18489.53776155607;18742.250309987994;18791.812081879005;18918.43244702661;16642;16836.494905152864;17125.82874171292;17178.055206963738;17296.740548891525;19425.125869336196;20846.270380536607;20887.8955605221;20938;20993;14958.177300248155;15025.248737563297;15130;15231.695366092394;15257.237138142826;18476.353327633467;18833;19168.329108481135;19173.233070677015;19213 04:09:34 INFO - PID 3592 | |3;mootools.html;1341;1385.7782754759241;1410.7178564287144;1411.922344271065;1412.9505467308645;13645.18128912266;14244.857551424482;14257.35841887115;14301.49944751934;15039.548813535584;15014.774778378305;15292.541223763305;15305.84694153058;15316.310766015527;15318;2628.053900595784;2680.638113854634;2733.070755942979;2736.521108805961;2745.1764470658823;2682.852443115628;2714.470678217748;2715.8777854996474;2719.4968930747873;2720.8911643534234;2658.8005899557515;2677.6385187999663;2684.543627583306;2688.8303587939213;2688.852113133777;2437.512497500507;2441.0235905637796;2463.2487091437106;2603.310122817455;2657.6545049143683;2367.0650093213258;2374.3707917401903;2380.3335066181326;2402.8197885158506;2407.0612461140167;14334.641633959234;14388.208648524327;14504.34730437133;14507.202103884281;14526.854731452657;7566.810829729246;7806;7815.374770018385;7835.294823465915;7847.372210223226;4956.975215123937;5124.795008199668;5184.11869982104;5276.050310944029;5295.179247216687;1832.7067669172868;1900.4366812227074;1905.3236101184157;1916.559191385989;1927.7686677598779;24128;24333.27000189997;24338;24391.390215244584;24434.26697199087;6250.968745156245;6333.714982825692;6404.135441715309;6471;6498.415142637185;16466.259018343964;16469.670606588043;16472.341106355852;16477.83522164787;16501.91749041247;7562;7693.038370203724;7719.3052625264;7720.112187098443;7721.691132354643;7112.502124851314;7122.358987691133;7126.322999315057;7132.928670713331;7202.279772022861;4929.580985616191;5067.645264831426;5077.390713114376;5086.287919691246;5157.458466860926;1480.7186634539403;1512.4706352776661;1533.0495093042384;1547.411983446283;1548.434821290221;881.9867701984475;904.2494729374604;908.4730856103445;919.8574220995756;919.8712180294764;7269.164046134762;7317.304856038668;7364.44766642504;7375.741849035258;7447.218042105609;711.6157275071404;719.1047146302886;721.0302143616932;723.7756295548397;724.0551080839555;4656.324832899279;5044.243363495431;5063.569596584258;5121.667091639031;5240.816571419982;18011.18949647269;18726.53183670419;20417;20469.59060818775;20508.794912050987;17210.39763608268;18555.443336699922;20443;20516.17935282572;20677.27629532959;10705.785884282272;11039.558417663204;11143.888561114447;11336.999999999834;11371.31772093677;8449;8662.566871656518;8695.739127826175;8713.25937295337;8788.692395766118;17814.643707126044;17894.91052544729;17919.73120403169;18081.90959045249;18608.255669773058;17764.822351776318;18279.725804113215;18429.81570184281;18506.16722247529;18637.534061648566;11730.12024098179;11827.112966527717;11985.34080625574;12005.879941200476;12057.15599908033;13370.598882033555;13552.32238388057;13577.389017494434;13586.728265434833;13587.728245434839;11177.944110279723;11181.664550063511;11280.492377842853;11492.82760758606;11537.307761534335;10946.945265273942;10994.835077474005;11009.779804404026;11039.668809935714;11219.439028048728;8982.281417486454;9173.678921237992;9185.173334399937;9186.908130918606;9188.678396256366;7212.350888420067;7249.855002900018;7334.96332518334;7357.19070902211;7378.225286344857;7569.810754731176;7657.387409007155;7660.885086723815;7663.88504172449;7736.342410895137 04:09:34 INFO - PID 3592 | |4;prototype.html;498.6735284144176;502.83909149072286;526.1266297945411;539.5171321667108;539.5764325004872;6357.332480089593;6407.679616019198;6445.613263204211;6468.9353106468925;6485.837854053651;6001.969990150054;6131.8916326061535;6189.876202475948;6214.223222097238;6250.218722659668;4932.950670493303;4965.379327584052;4994.7003179809235;5026.447090820006;5041.59667226621;4928.654994150411;4929.65492415531;4950.777215025332;5009.749512524378;5037.823676171335;4828.444728856191;4940;4973.875653108683;4990.525900039509;5030.773615187307;5002.649814513004;5030.798768049273;5035.370578677665;5042.3360291103845;5059.544640982293;4500.617447516965;4502.57225563571;4556.384888040138;4576.542345765397;4578.886357277051;6151.3541078187045;6169;6190.41191086846;6224.937750622526;6237.500999919996;5734.942650573525;5782.595218334718;5790.7683692652245;5801.7099145043;5832.387599302055;6492.188476440445;6529.183852018497;6598.637074960875;6615.768448104293;6621.768238111691;4892.608591312686;4915.525342397266;4933.1120398328285;4933.531314525115;4953.851384458472;6945.861082778316;6962.7911162665205;6968.930310696929;7049.06565404214;7082.92917070833;5074.340335756328;5078.314427552233;5087.160618497906;5089.821856235014;5100.5409513143995;5134.974325128351;5146.279520867081;5155.819546315861;5156.767945442464;5160.20016897374;5719.226175304973;5737.766380228271;5776.682282474504;5812.941870581325;5819.70901454934;6624.470042396597;6669.199696036507;6677.1319728435965;6716.932830671729;6717.126773519509;1688.5947372630726;1715.6568686262797;1730.4030109612163;1758.8241175882565;1787.4101546489628;1221.5236057937411;1232.5870833270776;1245.975080498385;1246.2771592476342;1264.9747005059846;5802.535797136219;5809.302883653989;5826.417358264224;5829.213056237439;5849.327327357323;6720.4287635550545;6752.291009444036;6783.219929708048;6863.965680171667;6882.518223724392;5759.6832174229985;5839.416058394127;5893.557983151195;5900.4984576310635;5929.762809487572;3579.4451859961746;3632.7820330780237;3637.181634132299;3646.4530320451613;3671.173985853162;6650.301718319603;6693.431058360094;6705.2624211336715;6712.697928593225;6736.292689267556;6969.756058538028;6996.860062798715;7031.718731250795;7073;7093.645317734093;6546.672666366662;6627.4484323534825;6638.601683898982;6674.799756007327;6675.997200839729;6690.732370705117;6832.59004459734;6846.158844079651;6886.655667216519;6936.930630693831;6810.353016463428;6841.692123854339;6862.588244705334;6866.793996180123;6923.6192009439965;6648.135742353463;6656.901611234092;6676.561570791144;6688.398044175853;6753.628550429774;4980.402351717672;5001.57486613642;5044.621653375938;5056.342675452315;5060.746962651926;6781.796546103427;6790.287019862843;6791.3548212919695;6845.828854278683;6901.137357830271;6650.135482387259;6680.565763225375;6693.364130407604;6716.731330746911;6720.361565651256;6268.461273184367;6523.347665233438;6566.212054553484;6599.307072757483;6664.566803157779;6185.783497577563;6355.713992870239;6462.4183823456115;6506.316836732075;6516.869662606627;6446;6586.604803711793;6672.866542669022;6675.566088204251;6677.499187561049;6281.748730050746;6346.809595712136;6379.234491861006;6436.420722134843;6461.160049193575 04:09:34 INFO - PID 3592 | |5;yui.html;903.3631289940593;921.3918813583028;926.180330407589;926.4117285523691;932.8181004704084;18388.44834654959;19680;19772.30796922108;19774.703379449318;19829.801701982975;21890.562188756216;22130.336089917328;22309.330720078422;22401.77598224017;22422.775772242272;1042.9061384475376;1078.7464945737784;1079.0666073846105;1079.1959989807565;1080.4273734920505;976.9413835169877;1013.7161594753444;1072.4369705904423;1074.2963358999868;1078.55240075369;1111.9888801112006;1112.844201811747;1114.5207560748875;1115.2082021764556;1117.6647005898199;1104.5305745058358;1113.1540029577498;1113.46553654246;1113.7215696075941;1113.9665810025713;808.4098608016122;810.7648781853255;812.4069429316633;813.2111851504031;813.6501304439089;18657.160427780647;18764.343247986257;18798;19498.610027799365;21119;19929.9003504983;20060.197592096298;20096.59806803856;20405.693914591295;20424;16784.58038549046;16875.746863797052;17037.91481042599;17148.657026859517;17246.913765431218;3578.6600272974024;3603.513525674027;3604.116991337113;3605.387084195693;3607.2424790793702;128986.48547300893;131074;131519.34240328736;133696.33151834275;134182.32908835492;16905.91547042257;17059.232334544977;17220.65558688819;17336.133193340283;17354.39259625907;31071.844640777104;31662;31663.525047124313;31764.20589485235;31872.36255274928;7431.8142046449275;7795.376369890395;8133.959330203429;8667;9047.638094476279;4054.716169868081;4144.026153853842;4147.937780933288;4149.37759336102;4151.045259590251;5259.658122222043;5345.064613692588;5347.064263753828;5375.543078838343;5383.865403364869;1037.6108959140322;1050.3277902142636;1062.888396718349;1063.8616979792732;1065.3607835298915;681.3969636871306;701.0920857489461;710.0343532795395;710.6967312920215;711.4201925430757;11670.766584668429;12039.036877049815;12169.2698438094;12487.250764954131;13220.801687974688;686.087503620184;687.9896801547981;698.0471656189266;708.3447810775012;709.8509313044318;5730.226419433407;5737.139429085587;6381.329960354189;6439.098526206335;6447.709853056624;107913;108128;110165;114892;116788.41605791917;95975.52012239894;100839;101311;101706;105042;85785.57107214548;85869;86476.5676171615;87191.56404218065;87257.56371218231;12188.756224875275;12319.815202772144;13041.804372934224;13103.868961310265;13520.661983450493;39304;39780.6076787311;40768.18463630651;41205.1758964825;41659.541916032795;69562.30437695558;71554.28445715684;71674.64162679153;72429.27570724436;75915.62042189753;19546.413607591796;19603.45155129824;19654;19720.901395492932;19779.703304450733;20947.581048379252;21705.674414884106;22207;22453.21413750576;22548.323550293517;18830.435086947415;19280.807191928463;19296.8070319295;19382.61234775325;19605.215791368184;16624.251908663897;16976.66046679035;17053.744193837352;17159.7426038607;17715.645687086442;17803.19885605125;17804.287828486715;18211.54471138232;18961.810381896004;19711.112999914752;12891.226526408445;12934.029947753768;13521.323933803074;13530.323483825967;13905.721885562434;14718.77921831152;15170.317335719697;15262.618434538781;15477.148756818484;15704.685906281582 04:09:34 INFO - PID 3592 | __end_tp_report 04:09:34 INFO - PID 3592 | __start_cc_report 04:09:34 INFO - PID 3592 | _x_x_mozilla_cycle_collect,360 04:09:34 INFO - PID 3592 | __end_cc_report 04:09:34 INFO - PID 3592 | __startTimestamp1502708974039__endTimestamp 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | ------- Summary: start ------- 04:09:34 INFO - PID 3592 | Number of tests: 6 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#0] dojo.html Cycles:165 Average:6132.21 Median:6342.84 stddev:723.86 (11.4%) stddev-sans-first:686.18 04:09:34 INFO - PID 3592 | Values: 3111.0 3151.1 3185.9 3198.3 3214.2 6093.2 6139.6 6214.3 6238.9 6275.5 6202.3 6216.6 6265.7 6277.0 6312.0 5472.8 5658.9 5737.0 5746.7 5787.9 5667.5 5751.9 5755.8 5762.1 5769.8 5648.1 5666.9 5732.3 5735.3 5757.6 5481.3 5628.2 5652.4 5719.4 5719.9 5580.7 5583.5 5596.3 5632.4 5688.5 6156.1 6166.5 6167.8 6174.8 6188.4 6643.7 6644.6 6686.3 6730.5 6735.5 6593.7 6690.6 6700.8 6707.2 6812.2 6179.8 6198.6 6215.5 6224.7 6273.0 6720.6 6724.1 6834.8 6932.7 6960.1 6472.2 6511.7 6546.2 6547.2 6663.1 6620.0 6680.0 6706.9 6714.6 6717.8 6604.7 6613.9 6671.4 6678.6 6705.8 6434.8 6555.8 6579.2 6579.7 6612.8 5352.6 5355.3 5358.8 5359.4 5366.3 4555.6 4617.6 4643.9 4684.0 4686.0 5712.8 5781.2 5797.6 5800.2 5809.8 6627.2 6636.4 6705.8 6729.6 6735.2 5633.0 5690.5 5702.7 5721.2 5753.7 5918.6 5926.1 5929.3 5939.3 5941.4 6451.0 6526.0 6532.7 6537.4 6547.5 6670.1 6688.5 6757.7 6773.3 6774.1 6265.2 6342.8 6425.2 6439.8 6449.0 6567.4 6604.8 6623.5 6628.7 6630.9 6715.2 6735.0 6742.1 6760.2 6821.4 6453.9 6488.9 6546.2 6559.8 6561.1 6319.9 6417.1 6436.2 6460.5 6554.3 6421.3 6427.5 6432.3 6435.3 6447.9 6440.3 6483.2 6587.4 6590.6 6597.0 6233.8 6253.7 6272.1 6282.5 6323.5 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#1] ext.html Cycles:180 Average:39475.89 Median:34204.07 stddev:57260.56 (167.4%) stddev-sans-first:57347.75 04:09:34 INFO - PID 3592 | Values: 854.4 881.7 906.8 1164.9 1194.6 32090.7 39640.8 40310.2 43643.8 43760.8 43652.6 44008.3 44105.1 44147.3 44304.0 7612.7 7643.4 7781.0 7792.5 7802.0 7618.4 7697.8 7700.5 7702.1 7716.1 7718.2 7771.4 7776.2 7778.3 7780.5 7720.7 7721.2 7762.5 7767.7 7768.5 7593.2 7623.8 7642.2 7669.4 7678.0 39463.6 39679.8 39736.2 39825.2 39837.6 3506.5 3559.0 3566.7 3568.5 3569.0 32801.2 33225.5 33303.3 33478.5 33510.0 4713.1 4960.1 4966.8 4993.0 4998.2 199192.0 199565.0 200690.0 201149.0 202392.0 49912.0 50347.0 50389.5 50405.2 50437.7 52601.2 52639.2 52760.5 52853.0 52883.7 15302.2 16561.2 16971.7 16976.0 16980.2 12809.0 13927.6 14179.1 14215.8 14241.1 15002.8 15071.0 15099.8 15099.8 15206.5 5917.1 5997.8 6029.9 6038.2 6079.8 984.2 1006.5 1027.5 1032.6 1033.9 23477.9 23592.9 23598.2 23707.6 23759.6 1120.8 1134.2 1143.2 1145.9 1148.7 12624.7 12697.9 12801.2 16232.7 16246.0 246019.0 246600.0 247528.0 247657.0 248321.0 60119.0 60466.4 60514.0 60531.7 60585.7 1469.2 1474.6 1498.3 1503.3 1510.1 26987.1 27126.3 27296.7 27362.7 27676.6 38572.6 38962.6 39037.4 39045.0 39082.2 210788.0 210873.0 211574.0 212090.0 212413.0 31171.5 31642.8 33402.2 33710.5 34697.7 44744.6 44760.6 44858.0 44998.0 45007.8 32649.0 32663.8 32697.8 32741.3 33666.3 32127.0 32625.5 32838.7 32953.7 33457.7 35148.3 35658.3 35681.6 35752.3 35806.5 31430.4 31473.4 31575.5 31789.0 31909.7 23114.5 23178.5 23385.4 23708.5 23743.5 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#2] jquery.html Cycles:180 Average:37541.08 Median:21187.42 stddev:91402.20 (431.4%) stddev-sans-first:91616.44 04:09:34 INFO - PID 3592 | Values: 562.3 570.9 573.4 581.9 586.5 23011.9 23758.4 23831.0 23840.5 23854.4 21822.9 22622.5 23568.9 23670.9 23779.0 6468.8 6646.8 6647.8 6649.0 6653.3 6294.9 6454.9 6508.7 6514.1 6554.0 6532.3 6532.8 6533.2 6538.0 6538.9 6518.5 6521.8 6523.2 6537.1 6544.9 6065.2 6070.2 6071.7 6077.8 6083.8 29798.4 30001.2 30601.8 31075.4 31200.0 2001.3 2011.7 2034.9 2035.0 2037.0 19714.8 20260.4 21162.0 21171.4 21203.5 2422.7 2457.7 2492.0 2502.1 2507.3 152310.0 160256.0 160257.2 160347.2 160676.2 14978.8 15241.8 15277.7 15756.7 15795.8 23591.3 23706.2 23754.3 23798.6 23846.6 10625.2 10646.6 10719.2 10900.1 10960.5 10136.5 10189.9 10222.5 10283.1 10391.0 9213.9 9326.3 9379.3 9539.7 9735.7 2648.2 2714.3 2721.9 2750.2 2878.2 957.4 983.9 1004.7 1005.0 1022.5 19370.6 19614.5 19616.3 19796.1 20045.0 1049.9 1059.9 1065.5 1071.7 1072.6 10831.6 13251.9 13554.7 14126.0 14403.8 527439.0 531776.0 541996.0 547034.0 556365.0 122962.4 124504.4 124692.4 124846.4 129502.0 1268.9 1282.0 1322.9 1326.9 1329.4 20311.6 20931.5 20937.3 20953.9 21261.5 57379.0 58029.0 58555.4 60714.7 62066.4 72658.0 73388.0 73778.0 74139.0 75184.6 14331.7 14547.2 14550.6 14565.4 14696.5 23425.3 23551.0 23628.9 23674.9 23694.0 18326.7 18489.5 18742.3 18791.8 18918.4 16642.0 16836.5 17125.8 17178.1 17296.7 19425.1 20846.3 20887.9 20938.0 20993.0 14958.2 15025.2 15130.0 15231.7 15257.2 18476.4 18833.0 19168.3 19173.2 19213.0 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#3] mootools.html Cycles:180 Average:8973.88 Median:13437.65 stddev:6245.47 (46.5%) stddev-sans-first:6236.66 04:09:34 INFO - PID 3592 | Values: 1341.0 1385.8 1410.7 1411.9 1413.0 13645.2 14244.9 14257.4 14301.5 15039.5 15014.8 15292.5 15305.8 15316.3 15318.0 2628.1 2680.6 2733.1 2736.5 2745.2 2682.9 2714.5 2715.9 2719.5 2720.9 2658.8 2677.6 2684.5 2688.8 2688.9 2437.5 2441.0 2463.2 2603.3 2657.7 2367.1 2374.4 2380.3 2402.8 2407.1 14334.6 14388.2 14504.3 14507.2 14526.9 7566.8 7806.0 7815.4 7835.3 7847.4 4957.0 5124.8 5184.1 5276.1 5295.2 1832.7 1900.4 1905.3 1916.6 1927.8 24128.0 24333.3 24338.0 24391.4 24434.3 6251.0 6333.7 6404.1 6471.0 6498.4 16466.3 16469.7 16472.3 16477.8 16501.9 7562.0 7693.0 7719.3 7720.1 7721.7 7112.5 7122.4 7126.3 7132.9 7202.3 4929.6 5067.6 5077.4 5086.3 5157.5 1480.7 1512.5 1533.0 1547.4 1548.4 882.0 904.2 908.5 919.9 919.9 7269.2 7317.3 7364.4 7375.7 7447.2 711.6 719.1 721.0 723.8 724.1 4656.3 5044.2 5063.6 5121.7 5240.8 18011.2 18726.5 20417.0 20469.6 20508.8 17210.4 18555.4 20443.0 20516.2 20677.3 10705.8 11039.6 11143.9 11337.0 11371.3 8449.0 8662.6 8695.7 8713.3 8788.7 17814.6 17894.9 17919.7 18081.9 18608.3 17764.8 18279.7 18429.8 18506.2 18637.5 11730.1 11827.1 11985.3 12005.9 12057.2 13370.6 13552.3 13577.4 13586.7 13587.7 11177.9 11181.7 11280.5 11492.8 11537.3 10946.9 10994.8 11009.8 11039.7 11219.4 8982.3 9173.7 9185.2 9186.9 9188.7 7212.4 7249.9 7335.0 7357.2 7378.2 7569.8 7657.4 7660.9 7663.9 7736.3 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#4] prototype.html Cycles:180 Average:5585.96 Median:6190.14 stddev:1577.26 (25.5%) stddev-sans-first:1534.77 04:09:34 INFO - PID 3592 | Values: 498.7 502.8 526.1 539.5 539.6 6357.3 6407.7 6445.6 6468.9 6485.8 6002.0 6131.9 6189.9 6214.2 6250.2 4933.0 4965.4 4994.7 5026.4 5041.6 4928.7 4929.7 4950.8 5009.7 5037.8 4828.4 4940.0 4973.9 4990.5 5030.8 5002.6 5030.8 5035.4 5042.3 5059.5 4500.6 4502.6 4556.4 4576.5 4578.9 6151.4 6169.0 6190.4 6224.9 6237.5 5734.9 5782.6 5790.8 5801.7 5832.4 6492.2 6529.2 6598.6 6615.8 6621.8 4892.6 4915.5 4933.1 4933.5 4953.9 6945.9 6962.8 6968.9 7049.1 7082.9 5074.3 5078.3 5087.2 5089.8 5100.5 5135.0 5146.3 5155.8 5156.8 5160.2 5719.2 5737.8 5776.7 5812.9 5819.7 6624.5 6669.2 6677.1 6716.9 6717.1 1688.6 1715.7 1730.4 1758.8 1787.4 1221.5 1232.6 1246.0 1246.3 1265.0 5802.5 5809.3 5826.4 5829.2 5849.3 6720.4 6752.3 6783.2 6864.0 6882.5 5759.7 5839.4 5893.6 5900.5 5929.8 3579.4 3632.8 3637.2 3646.5 3671.2 6650.3 6693.4 6705.3 6712.7 6736.3 6969.8 6996.9 7031.7 7073.0 7093.6 6546.7 6627.4 6638.6 6674.8 6676.0 6690.7 6832.6 6846.2 6886.7 6936.9 6810.4 6841.7 6862.6 6866.8 6923.6 6648.1 6656.9 6676.6 6688.4 6753.6 4980.4 5001.6 5044.6 5056.3 5060.7 6781.8 6790.3 6791.4 6845.8 6901.1 6650.1 6680.6 6693.4 6716.7 6720.4 6268.5 6523.3 6566.2 6599.3 6664.6 6185.8 6355.7 6462.4 6506.3 6516.9 6446.0 6586.6 6672.9 6675.6 6677.5 6281.7 6346.8 6379.2 6436.4 6461.2 04:09:34 INFO - PID 3592 | 04:09:34 INFO - PID 3592 | [#5] yui.html Cycles:180 Average:24362.79 Median:19695.56 stddev:33035.03 (167.7%) stddev-sans-first:33080.74 04:09:34 INFO - PID 3592 | Values: 903.4 921.4 926.2 926.4 932.8 18388.4 19680.0 19772.3 19774.7 19829.8 21890.6 22130.3 22309.3 22401.8 22422.8 1042.9 1078.7 1079.1 1079.2 1080.4 976.9 1013.7 1072.4 1074.3 1078.6 1112.0 1112.8 1114.5 1115.2 1117.7 1104.5 1113.2 1113.5 1113.7 1114.0 808.4 810.8 812.4 813.2 813.7 18657.2 18764.3 18798.0 19498.6 21119.0 19929.9 20060.2 20096.6 20405.7 20424.0 16784.6 16875.7 17037.9 17148.7 17246.9 3578.7 3603.5 3604.1 3605.4 3607.2 128986.5 131074.0 131519.3 133696.3 134182.3 16905.9 17059.2 17220.7 17336.1 17354.4 31071.8 31662.0 31663.5 31764.2 31872.4 7431.8 7795.4 8134.0 8667.0 9047.6 4054.7 4144.0 4147.9 4149.4 4151.0 5259.7 5345.1 5347.1 5375.5 5383.9 1037.6 1050.3 1062.9 1063.9 1065.4 681.4 701.1 710.0 710.7 711.4 11670.8 12039.0 12169.3 12487.3 13220.8 686.1 688.0 698.0 708.3 709.9 5730.2 5737.1 6381.3 6439.1 6447.7 107913.0 108128.0 110165.0 114892.0 116788.4 95975.5 100839.0 101311.0 101706.0 105042.0 85785.6 85869.0 86476.6 87191.6 87257.6 12188.8 12319.8 13041.8 13103.9 13520.7 39304.0 39780.6 40768.2 41205.2 41659.5 69562.3 71554.3 71674.6 72429.3 75915.6 19546.4 19603.5 19654.0 19720.9 19779.7 20947.6 21705.7 22207.0 22453.2 22548.3 18830.4 19280.8 19296.8 19382.6 19605.2 16624.3 16976.7 17053.7 17159.7 17715.6 17803.2 17804.3 18211.5 18961.8 19711.1 12891.2 12934.0 13521.3 13530.3 13905.7 14718.8 15170.3 15262.6 15477.1 15704.7 04:09:34 INFO - PID 3592 | -------- Summary: end -------- 04:09:34 INFO - PID 3592 | 04:09:34 INFO - TEST-INFO | 3592: exit 0 04:09:34 INFO - TEST-OK | dromaeo_css | took 1113413ms 04:09:34 INFO - TEST-START | kraken 04:09:34 INFO - Initialising browser for kraken test... 04:09:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41400/getInfo.html -profile /tmp/tmp64dlAW/profile 04:09:34 INFO - TEST-INFO | started process 3952 (/builds/slave/test/build/application/firefox/firefox http://localhost:41400/getInfo.html) 04:09:40 INFO - TEST-INFO | 3952: exit 0 04:09:40 INFO - Browser initialized. 04:09:40 INFO - Running cycle 1/1 for kraken test... 04:09:40 INFO - TEST-INFO | started process 4165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp64dlAW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:41 INFO - PID 4165 | 04:09:41 INFO - PID 4165 | (/builds/slave/test/build/application/firefox/firefox:4213): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:41 INFO - PID 4165 | 04:09:52 INFO - PID 4165 | RSS: Main: 165683200 04:09:52 INFO - PID 4165 | 04:09:54 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41400/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:55 INFO - PID 4165 | RSS: Main: 172883968 04:09:55 INFO - PID 4165 | 04:09:58 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41400/tests/kraken/driver.html?testName=audio-dft) 04:09:58 INFO - PID 4165 | RSS: Main: 172748800 04:09:58 INFO - PID 4165 | 04:10:01 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41400/tests/kraken/driver.html?testName=audio-fft) 04:10:02 INFO - PID 4165 | RSS: Main: 166854656 04:10:02 INFO - PID 4165 | 04:10:04 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41400/tests/kraken/driver.html?testName=audio-oscillator) 04:10:05 INFO - PID 4165 | RSS: Main: 167710720 04:10:05 INFO - PID 4165 | 04:10:07 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:08 INFO - PID 4165 | RSS: Main: 167886848 04:10:08 INFO - PID 4165 | 04:10:11 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41400/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:11 INFO - PID 4165 | RSS: Main: 170528768 04:10:11 INFO - PID 4165 | 04:10:15 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41400/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:15 INFO - PID 4165 | RSS: Main: 172855296 04:10:15 INFO - PID 4165 | 04:10:18 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41400/tests/kraken/driver.html?testName=json-parse-financial) 04:10:19 INFO - PID 4165 | RSS: Main: 172109824 04:10:19 INFO - PID 4165 | 04:10:20 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:21 INFO - PID 4165 | RSS: Main: 172113920 04:10:21 INFO - PID 4165 | 04:10:23 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:23 INFO - PID 4165 | RSS: Main: 171798528 04:10:23 INFO - PID 4165 | 04:10:26 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:26 INFO - PID 4165 | RSS: Main: 171868160 04:10:26 INFO - PID 4165 | 04:10:29 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:30 INFO - PID 4165 | RSS: Main: 171868160 04:10:30 INFO - PID 4165 | 04:10:33 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:33 INFO - PID 4165 | RSS: Main: 171962368 04:10:33 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:41400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41400/tests/kraken/driver.html?testName=ai-astar) 04:10:35 INFO - PID 4165 | RSS: Main: 173678592 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | __start_tp_report 04:10:35 INFO - PID 4165 | _x_x_mozilla_page_load 04:10:35 INFO - PID 4165 | _x_x_mozilla_page_load_details 04:10:35 INFO - PID 4165 | |i|pagename|runs| 04:10:35 INFO - PID 4165 | |0;ai-astar;100;109;102;107;110;109;108;101;108;109 04:10:35 INFO - PID 4165 | |1;audio-beat-detection;147;119;143;173;119;141;141;119;165;116 04:10:35 INFO - PID 4165 | |2;audio-dft;163;164;163;162;163;162;164;164;175;171 04:10:35 INFO - PID 4165 | |3;audio-fft;76;76;75;109;78;86;77;91;99;76 04:10:35 INFO - PID 4165 | |4;audio-oscillator;79;77;130;79;79;79;124;79;79;126 04:10:35 INFO - PID 4165 | |5;imaging-gaussian-blur;115;114;114;113;115;114;115;114;114;113 04:10:35 INFO - PID 4165 | |6;imaging-darkroom;155;150;150;150;149;149;150;149;151;149 04:10:35 INFO - PID 4165 | |7;imaging-desaturate;93;94;100;93;94;93;94;95;94;95 04:10:35 INFO - PID 4165 | |8;json-parse-financial;54;54;56;54;54;55;54;54;61;54 04:10:35 INFO - PID 4165 | |9;json-stringify-tinderbox;55;54;53;54;53;55;54;54;54;54 04:10:35 INFO - PID 4165 | |10;stanford-crypto-aes;81;78;76;93;77;77;78;79;79;78 04:10:35 INFO - PID 4165 | |11;stanford-crypto-ccm;126;127;132;128;143;127;124;128;122;172 04:10:35 INFO - PID 4165 | |12;stanford-crypto-pbkdf2;197;179;181;175;180;177;184;171;177;175 04:10:35 INFO - PID 4165 | |13;stanford-crypto-sha256-iterative;72;70;70;67;69;76;80;68;67;78 04:10:35 INFO - PID 4165 | __end_tp_report 04:10:35 INFO - PID 4165 | __start_cc_report 04:10:35 INFO - PID 4165 | _x_x_mozilla_cycle_collect,952 04:10:35 INFO - PID 4165 | __end_cc_report 04:10:35 INFO - PID 4165 | __startTimestamp1502709035856__endTimestamp 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | ------- Summary: start ------- 04:10:35 INFO - PID 4165 | Number of tests: 14 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#0] ai-astar Cycles:10 Average:106.30 Median:108.50 stddev:3.77 (3.5%) stddev-sans-first:3.24 04:10:35 INFO - PID 4165 | Values: 100.0 109.0 102.0 107.0 110.0 109.0 108.0 101.0 108.0 109.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:142.00 stddev:20.12 (14.2%) stddev-sans-first:21.10 04:10:35 INFO - PID 4165 | Values: 147.0 119.0 143.0 173.0 119.0 141.0 141.0 119.0 165.0 116.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.33 (2.6%) stddev-sans-first:4.53 04:10:35 INFO - PID 4165 | Values: 163.0 164.0 163.0 162.0 163.0 162.0 164.0 164.0 175.0 171.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#3] audio-fft Cycles:10 Average:84.30 Median:77.50 stddev:11.83 (15.3%) stddev-sans-first:12.16 04:10:35 INFO - PID 4165 | Values: 76.0 76.0 75.0 109.0 78.0 86.0 77.0 91.0 99.0 76.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:79.00 stddev:23.22 (29.4%) stddev-sans-first:24.06 04:10:35 INFO - PID 4165 | Values: 79.0 77.0 130.0 79.0 79.0 79.0 124.0 79.0 79.0 126.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 04:10:35 INFO - PID 4165 | Values: 115.0 114.0 114.0 113.0 115.0 114.0 115.0 114.0 114.0 113.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:1.81 (1.2%) stddev-sans-first:0.71 04:10:35 INFO - PID 4165 | Values: 155.0 150.0 150.0 150.0 149.0 149.0 150.0 149.0 151.0 149.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.07 (2.2%) stddev-sans-first:2.12 04:10:35 INFO - PID 4165 | Values: 93.0 94.0 100.0 93.0 94.0 93.0 94.0 95.0 94.0 95.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:2.21 (4.1%) stddev-sans-first:2.32 04:10:35 INFO - PID 4165 | Values: 54.0 54.0 56.0 54.0 54.0 55.0 54.0 54.0 61.0 54.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 04:10:35 INFO - PID 4165 | Values: 55.0 54.0 53.0 54.0 53.0 55.0 54.0 54.0 54.0 54.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.50 stddev:4.90 (6.2%) stddev-sans-first:5.17 04:10:35 INFO - PID 4165 | Values: 81.0 78.0 76.0 93.0 77.0 77.0 78.0 79.0 79.0 78.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:128.00 stddev:14.89 (11.6%) stddev-sans-first:15.58 04:10:35 INFO - PID 4165 | Values: 126.0 127.0 132.0 128.0 143.0 127.0 124.0 128.0 122.0 172.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.50 stddev:7.11 (4.0%) stddev-sans-first:3.84 04:10:35 INFO - PID 4165 | Values: 197.0 179.0 181.0 175.0 180.0 177.0 184.0 171.0 177.0 175.0 04:10:35 INFO - PID 4165 | 04:10:35 INFO - PID 4165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:71.00 stddev:4.69 (6.6%) stddev-sans-first:4.97 04:10:35 INFO - PID 4165 | Values: 72.0 70.0 70.0 67.0 69.0 76.0 80.0 68.0 67.0 78.0 04:10:35 INFO - PID 4165 | -------- Summary: end -------- 04:10:35 INFO - PID 4165 | 04:10:36 INFO - PID 4165 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:10:36 INFO - TEST-INFO | 4165: exit 0 04:10:36 INFO - TEST-OK | kraken | took 61951ms 04:10:36 INFO - SUITE-END | took 1175s 04:10:37 INFO - Completed test suite (00:19:35) 04:10:37 INFO - javascript benchmark 04:10:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8644.134639468039, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.9688903110964, 3151.070434221903, 3185.936281274374, 3198.2963747975446, 3214.1964508872784, 6093.177421048163, 6139.600925939811, 6214.316425193225, 6238.875222495547, 6275.466585340251, 6202.3487533808975, 6216.595921265114, 6265.718042688079, 6277.0, 6312.0, 5472.835814925539, 5658.91511627326, 5736.971315143418, 5746.655200687951, 5787.884242315151, 5667.4615911488345, 5751.856203594902, 5755.827325180251, 5762.135679648044, 5769.798057068004, 5648.096304591266, 5666.914996275059, 5732.254806875121, 5735.2544169257935, 5757.596968212227, 5481.342238931314, 5628.155776633497, 5652.434756524356, 5719.370869204384, 5719.857003574903, 5580.665160090408, 5583.497485226349, 5596.3284405871145, 5632.352279487829, 5688.459596338341, 6156.076588511714, 6166.506679465677, 6167.7532898684, 6174.7530098796, 6188.381161883775, 6643.667816609151, 6644.568103073333, 6686.297938716413, 6730.528862979593, 6735.461163106939, 6593.703283352261, 6690.59856408617, 6700.798976030727, 6707.228668703064, 6812.182538095411, 6179.84550386244, 6198.566100372931, 6215.502759779207, 6224.719887605114, 6272.968635156886, 6720.630365329856, 6724.058631791553, 6834.794956151323, 6932.688029038705, 6960.129983752031, 6472.223333200046, 6511.706973186218, 6546.214454265519, 6547.247066587308, 6663.06717059612, 6620.040094186316, 6680.0, 6706.865862682816, 6714.563553369016, 6717.832054198684, 6604.702788374535, 6613.900791488131, 6671.366220209073, 6678.632675202911, 6705.765298214539, 6434.806955791334, 6555.80332590023, 6579.210494740566, 6579.703913323912, 6612.801615951529, 5352.598555108382, 5355.250264962909, 5358.839234822962, 5359.383670877821, 5366.302380690563, 4555.567221113989, 4617.58441740245, 4643.86068417948, 4684.0, 4686.0, 5712.828615141552, 5781.219535362757, 5797.594168408255, 5800.1589769484035, 5809.82570522885, 6627.1716035495565, 6636.402723754885, 6705.798826035129, 6729.629870357177, 6735.225449073321, 5633.0, 5690.5447564194765, 5702.7433765480655, 5721.170430287585, 5753.712314384264, 5918.585699001114, 5926.140709597084, 5929.318128415288, 5939.287285525765, 5941.405859414024, 6451.0, 6526.0, 6532.6733663316645, 6537.444317232993, 6547.476201903932, 6670.066190733398, 6688.4983626229205, 6757.729690812313, 6773.288804675635, 6774.085498457645, 6265.154204182377, 6342.841428964312, 6425.1968503937005, 6439.774607888701, 6448.967755161194, 6567.408933196035, 6604.768833091011, 6623.470122390101, 6628.734850606114, 6630.939049752016, 6715.160604924385, 6734.966325168343, 6742.089817874524, 6760.222574404006, 6821.386075253251, 6453.903191452038, 6488.902666459912, 6546.18172728409, 6559.770408035887, 6561.114249576246, 6319.936800631935, 6417.101605775102, 6436.195475565554, 6460.549590174107, 6554.311797261219, 6421.293657697743, 6427.485801135805, 6432.2602900667025, 6435.324290949383, 6447.903281450688, 6440.25937017249, 6483.157189565326, 6587.440067594308, 6590.637514936724, 6597.0, 6233.781817636361, 6253.7185826637, 6272.09054687077, 6282.528810339151, 6323.494120470259], "value": 6078.210347159664, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.4189950833431, 881.709036018114, 906.7778394293397, 1164.9475773590182, 1194.5639841457871, 32090.679093209063, 39640.80179599105, 40310.1937961241, 43643.78178109113, 43760.78119609405, 43652.56347436525, 44008.3398749019, 44105.11789764203, 44147.337789933175, 44304.0, 7612.657430415617, 7643.388528917687, 7781.027371578552, 7792.493487923295, 7802.024746906637, 7618.428617853656, 7697.807554811118, 7700.537967721926, 7702.114256860449, 7716.112647045577, 7718.189590093044, 7771.3782897368355, 7776.222377762235, 7778.299953004229, 7780.533168009909, 7720.729774457923, 7721.150673425918, 7762.45662803604, 7767.650455729506, 7768.456208065438, 7593.240675932418, 7623.771286861403, 7642.159362470124, 7669.38644908406, 7677.961610191914, 39463.60536394657, 39679.8016009921, 39736.20527589432, 39825.20349593021, 39837.601623983675, 3506.50908872758, 3558.982205088984, 3566.6789988901123, 3568.4825700273573, 3568.982155089208, 32801.17997050069, 33225.501617475755, 33303.3339333212, 33478.497822532685, 33510.0, 4713.128071306819, 4960.107180707471, 4966.751662416901, 4993.0263598598285, 4998.150314446553, 199192.0, 199565.0, 200690.0, 201149.0, 202392.0, 49912.0, 50347.0, 50389.49610503848, 50405.24392134121, 50437.747811260706, 52601.210981835306, 52639.21041184385, 52760.47239527632, 52853.0, 52883.735581321846, 15302.158381289137, 16561.17194140288, 16971.74542381865, 16976.0, 16980.150992450574, 12809.0, 13927.582172534638, 14179.078359906573, 14215.786763198561, 14241.074330168505, 15002.849971500145, 15071.0, 15099.849001509845, 15099.849001510063, 15206.543803685907, 5917.112433134978, 5997.790077347272, 6029.939700602938, 6038.184845045863, 6079.75680972765, 984.1536278800226, 1006.4866917871938, 1027.4605831938293, 1032.6024480575034, 1033.9121174700085, 23477.88261058684, 23592.88203558971, 23598.17406390768, 23707.644385334235, 23759.643605345933, 1120.7646394257297, 1134.2457265918072, 1143.2283208834003, 1145.9369734664674, 1148.7300484386162, 12624.747505049847, 12697.873021269668, 12801.231926084465, 16232.675346493004, 16246.0, 246019.0, 246600.0, 247528.0, 247657.0, 248321.0, 60119.0, 60466.39533604607, 60514.0, 60531.69734151301, 60585.69707151436, 1469.1846025455761, 1474.6165996840684, 1498.2958009735407, 1503.2934520775218, 1510.1165817996596, 26987.05545305905, 27126.321841954108, 27296.727032729417, 27362.726372736815, 27676.58485122765, 38572.6142738569, 38962.610373897034, 39037.41443878287, 39045.0, 39082.2183556333, 210788.0, 210873.0, 211574.0, 212090.0, 212413.0, 31171.532427014066, 31642.841785790923, 33402.16494587558, 33710.49434258439, 34697.653023470455, 44744.55255447404, 44760.552394475635, 44858.0, 44998.0, 45007.77496112498, 32649.0, 32663.836680817396, 32697.836510817295, 32741.34517309688, 33666.32667346689, 32127.0, 32625.510617341235, 32838.671613283565, 32953.67046329506, 33457.665423345454, 35148.29703405969, 35658.28683426369, 35681.64318356783, 35752.284954300245, 35806.46290305595, 31430.371392572477, 31473.370532589677, 31575.526367104972, 31789.0, 31909.68090319067, 23114.537709245385, 23178.536429270982, 23385.41536461602, 23708.52582948297, 23743.52512949766], "value": 17785.66647417806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.3465820336713, 570.9229254050701, 573.4494884910486, 581.8865321262352, 586.4516676907092, 23011.884940575295, 23758.40603984899, 23831.0, 23840.523189536198, 23854.403639908967, 21822.89088554559, 22622.54754904901, 23568.88215558924, 23670.93480793364, 23779.0, 6468.773592924261, 6646.767363142291, 6647.8338041549105, 6648.966755166218, 6653.2681405045405, 6294.937050629504, 6454.935450645504, 6508.707108180143, 6514.055461958013, 6554.016897465371, 6532.281449040602, 6532.771353002646, 6533.248676402203, 6537.967310163466, 6538.901916471256, 6518.511111666644, 6521.804345869631, 6523.217213934358, 6537.084808126866, 6544.901826472606, 6065.150878876961, 6070.180525629028, 6071.696415179267, 6077.7568897244055, 6083.7870674526175, 29798.40403191924, 30001.249968750955, 30601.846990765127, 31075.378492430253, 31200.0, 2001.269536619138, 2011.6580181369202, 2034.8982550872397, 2035.0435295411132, 2037.0324096054403, 19714.80285197144, 20260.392188234375, 21162.0, 21171.364859054254, 21203.46991325229, 2422.733499315074, 2457.6682147909983, 2491.95016099677, 2502.06172685243, 2507.2728908616477, 152310.0, 160256.0, 160257.19871400567, 160347.1982640091, 160676.19661901615, 14978.844004470675, 15241.847581524265, 15277.694446111016, 15756.68486630284, 15795.840831833679, 23591.29226123219, 23706.170284039978, 23754.287371378887, 23798.64302035471, 23846.642300365507, 10625.203109766799, 10646.574137034588, 10719.19606029551, 10900.1279897608, 10960.506777195045, 10136.493175341204, 10189.898101019044, 10222.539985700661, 10283.125934295518, 10391.0, 9213.894332680122, 9326.347155699035, 9379.343445958853, 9539.713808585753, 9735.734354533864, 2648.1525911708454, 2714.3349879279704, 2721.931951701223, 2750.2161883863005, 2878.2372671242138, 957.368137029571, 983.8524221366853, 1004.7488127968008, 1004.9899501004896, 1022.5449674894601, 19370.612587748165, 19614.497759056154, 19616.3134290302, 19796.109175087156, 20045.0, 1049.900259475364, 1059.8728152621734, 1065.4566171252718, 1071.7427817323942, 1072.6406653770919, 10831.566737330419, 13251.867481325256, 13554.661133471742, 14126.011179217356, 14403.78394324086, 527439.0, 531776.0, 541996.0, 547034.0, 556365.0, 122962.38518807528, 124504.37747811203, 124692.37653811673, 124846.37576812058, 129502.0, 1268.9428975696117, 1281.9743605128033, 1322.907396482237, 1326.9270190139441, 1329.3951252180427, 20311.59376812485, 20931.476713082295, 20937.26719564808, 20953.89523052375, 21261.46846328854, 57379.0, 58029.0, 58555.4144458567, 60714.696426517585, 62066.37933620606, 72658.0, 73388.0, 73778.0, 74139.0, 75184.62407687926, 14331.713365732418, 14547.199904005382, 14550.636234094232, 14565.417383304974, 14696.485623003144, 23425.297241082793, 23551.0, 23628.88185559061, 23674.88162559245, 23694.0, 18326.725099123258, 18489.53776155607, 18742.250309987994, 18791.812081879005, 18918.43244702661, 16642.0, 16836.494905152864, 17125.82874171292, 17178.055206963738, 17296.740548891525, 19425.125869336196, 20846.270380536607, 20887.8955605221, 20938.0, 20993.0, 14958.177300248155, 15025.248737563297, 15130.0, 15231.695366092394, 15257.237138142826, 18476.353327633467, 18833.0, 19168.329108481135, 19173.233070677015, 19213.0], "value": 12446.945447998329, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.0, 1385.7782754759241, 1410.7178564287144, 1411.922344271065, 1412.9505467308645, 13645.18128912266, 14244.857551424482, 14257.35841887115, 14301.49944751934, 15039.548813535584, 15014.774778378305, 15292.541223763305, 15305.84694153058, 15316.310766015527, 15318.0, 2628.053900595784, 2680.638113854634, 2733.070755942979, 2736.521108805961, 2745.1764470658823, 2682.852443115628, 2714.470678217748, 2715.8777854996474, 2719.4968930747873, 2720.8911643534234, 2658.8005899557515, 2677.6385187999663, 2684.543627583306, 2688.8303587939213, 2688.852113133777, 2437.512497500507, 2441.0235905637796, 2463.2487091437106, 2603.310122817455, 2657.6545049143683, 2367.0650093213258, 2374.3707917401903, 2380.3335066181326, 2402.8197885158506, 2407.0612461140167, 14334.641633959234, 14388.208648524327, 14504.34730437133, 14507.202103884281, 14526.854731452657, 7566.810829729246, 7806.0, 7815.374770018385, 7835.294823465915, 7847.372210223226, 4956.975215123937, 5124.795008199668, 5184.11869982104, 5276.050310944029, 5295.179247216687, 1832.7067669172868, 1900.4366812227074, 1905.3236101184157, 1916.559191385989, 1927.7686677598779, 24128.0, 24333.27000189997, 24338.0, 24391.390215244584, 24434.26697199087, 6250.968745156245, 6333.714982825692, 6404.135441715309, 6471.0, 6498.415142637185, 16466.259018343964, 16469.670606588043, 16472.341106355852, 16477.83522164787, 16501.91749041247, 7562.0, 7693.038370203724, 7719.3052625264, 7720.112187098443, 7721.691132354643, 7112.502124851314, 7122.358987691133, 7126.322999315057, 7132.928670713331, 7202.279772022861, 4929.580985616191, 5067.645264831426, 5077.390713114376, 5086.287919691246, 5157.458466860926, 1480.7186634539403, 1512.4706352776661, 1533.0495093042384, 1547.411983446283, 1548.434821290221, 881.9867701984475, 904.2494729374604, 908.4730856103445, 919.8574220995756, 919.8712180294764, 7269.164046134762, 7317.304856038668, 7364.44766642504, 7375.741849035258, 7447.218042105609, 711.6157275071404, 719.1047146302886, 721.0302143616932, 723.7756295548397, 724.0551080839555, 4656.324832899279, 5044.243363495431, 5063.569596584258, 5121.667091639031, 5240.816571419982, 18011.18949647269, 18726.53183670419, 20417.0, 20469.59060818775, 20508.794912050987, 17210.39763608268, 18555.443336699922, 20443.0, 20516.17935282572, 20677.27629532959, 10705.785884282272, 11039.558417663204, 11143.888561114447, 11336.999999999834, 11371.31772093677, 8449.0, 8662.566871656518, 8695.739127826175, 8713.25937295337, 8788.692395766118, 17814.643707126044, 17894.91052544729, 17919.73120403169, 18081.90959045249, 18608.255669773058, 17764.822351776318, 18279.725804113215, 18429.81570184281, 18506.16722247529, 18637.534061648566, 11730.12024098179, 11827.112966527717, 11985.34080625574, 12005.879941200476, 12057.15599908033, 13370.598882033555, 13552.32238388057, 13577.389017494434, 13586.728265434833, 13587.728245434839, 11177.944110279723, 11181.664550063511, 11280.492377842853, 11492.82760758606, 11537.307761534335, 10946.945265273942, 10994.835077474005, 11009.779804404026, 11039.668809935714, 11219.439028048728, 8982.281417486454, 9173.678921237992, 9185.173334399937, 9186.908130918606, 9188.678396256366, 7212.350888420067, 7249.855002900018, 7334.96332518334, 7357.19070902211, 7378.225286344857, 7569.810754731176, 7657.387409007155, 7660.885086723815, 7663.88504172449, 7736.342410895137], "value": 6438.453936722863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.6735284144176, 502.83909149072286, 526.1266297945411, 539.5171321667108, 539.5764325004872, 6357.332480089593, 6407.679616019198, 6445.613263204211, 6468.9353106468925, 6485.837854053651, 6001.969990150054, 6131.8916326061535, 6189.876202475948, 6214.223222097238, 6250.218722659668, 4932.950670493303, 4965.379327584052, 4994.7003179809235, 5026.447090820006, 5041.59667226621, 4928.654994150411, 4929.65492415531, 4950.777215025332, 5009.749512524378, 5037.823676171335, 4828.444728856191, 4940.0, 4973.875653108683, 4990.525900039509, 5030.773615187307, 5002.649814513004, 5030.798768049273, 5035.370578677665, 5042.3360291103845, 5059.544640982293, 4500.617447516965, 4502.57225563571, 4556.384888040138, 4576.542345765397, 4578.886357277051, 6151.3541078187045, 6169.0, 6190.41191086846, 6224.937750622526, 6237.500999919996, 5734.942650573525, 5782.595218334718, 5790.7683692652245, 5801.7099145043, 5832.387599302055, 6492.188476440445, 6529.183852018497, 6598.637074960875, 6615.768448104293, 6621.768238111691, 4892.608591312686, 4915.525342397266, 4933.1120398328285, 4933.531314525115, 4953.851384458472, 6945.861082778316, 6962.7911162665205, 6968.930310696929, 7049.06565404214, 7082.92917070833, 5074.340335756328, 5078.314427552233, 5087.160618497906, 5089.821856235014, 5100.5409513143995, 5134.974325128351, 5146.279520867081, 5155.819546315861, 5156.767945442464, 5160.20016897374, 5719.226175304973, 5737.766380228271, 5776.682282474504, 5812.941870581325, 5819.70901454934, 6624.470042396597, 6669.199696036507, 6677.1319728435965, 6716.932830671729, 6717.126773519509, 1688.5947372630726, 1715.6568686262797, 1730.4030109612163, 1758.8241175882565, 1787.4101546489628, 1221.5236057937411, 1232.5870833270776, 1245.975080498385, 1246.2771592476342, 1264.9747005059846, 5802.535797136219, 5809.302883653989, 5826.417358264224, 5829.213056237439, 5849.327327357323, 6720.4287635550545, 6752.291009444036, 6783.219929708048, 6863.965680171667, 6882.518223724392, 5759.6832174229985, 5839.416058394127, 5893.557983151195, 5900.4984576310635, 5929.762809487572, 3579.4451859961746, 3632.7820330780237, 3637.181634132299, 3646.4530320451613, 3671.173985853162, 6650.301718319603, 6693.431058360094, 6705.2624211336715, 6712.697928593225, 6736.292689267556, 6969.756058538028, 6996.860062798715, 7031.718731250795, 7073.0, 7093.645317734093, 6546.672666366662, 6627.4484323534825, 6638.601683898982, 6674.799756007327, 6675.997200839729, 6690.732370705117, 6832.59004459734, 6846.158844079651, 6886.655667216519, 6936.930630693831, 6810.353016463428, 6841.692123854339, 6862.588244705334, 6866.793996180123, 6923.6192009439965, 6648.135742353463, 6656.901611234092, 6676.561570791144, 6688.398044175853, 6753.628550429774, 4980.402351717672, 5001.57486613642, 5044.621653375938, 5056.342675452315, 5060.746962651926, 6781.796546103427, 6790.287019862843, 6791.3548212919695, 6845.828854278683, 6901.137357830271, 6650.135482387259, 6680.565763225375, 6693.364130407604, 6716.731330746911, 6720.361565651256, 6268.461273184367, 6523.347665233438, 6566.212054553484, 6599.307072757483, 6664.566803157779, 6185.783497577563, 6355.713992870239, 6462.4183823456115, 6506.316836732075, 6516.869662606627, 6446.0, 6586.604803711793, 6672.866542669022, 6675.566088204251, 6677.499187561049, 6281.748730050746, 6346.809595712136, 6379.234491861006, 6436.420722134843, 6461.160049193575], "value": 5121.321091380319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.3631289940593, 921.3918813583028, 926.180330407589, 926.4117285523691, 932.8181004704084, 18388.44834654959, 19680.0, 19772.30796922108, 19774.703379449318, 19829.801701982975, 21890.562188756216, 22130.336089917328, 22309.330720078422, 22401.77598224017, 22422.775772242272, 1042.9061384475376, 1078.7464945737784, 1079.0666073846105, 1079.1959989807565, 1080.4273734920505, 976.9413835169877, 1013.7161594753444, 1072.4369705904423, 1074.2963358999868, 1078.55240075369, 1111.9888801112006, 1112.844201811747, 1114.5207560748875, 1115.2082021764556, 1117.6647005898199, 1104.5305745058358, 1113.1540029577498, 1113.46553654246, 1113.7215696075941, 1113.9665810025713, 808.4098608016122, 810.7648781853255, 812.4069429316633, 813.2111851504031, 813.6501304439089, 18657.160427780647, 18764.343247986257, 18798.0, 19498.610027799365, 21119.0, 19929.9003504983, 20060.197592096298, 20096.59806803856, 20405.693914591295, 20424.0, 16784.58038549046, 16875.746863797052, 17037.91481042599, 17148.657026859517, 17246.913765431218, 3578.6600272974024, 3603.513525674027, 3604.116991337113, 3605.387084195693, 3607.2424790793702, 128986.48547300893, 131074.0, 131519.34240328736, 133696.33151834275, 134182.32908835492, 16905.91547042257, 17059.232334544977, 17220.65558688819, 17336.133193340283, 17354.39259625907, 31071.844640777104, 31662.0, 31663.525047124313, 31764.20589485235, 31872.36255274928, 7431.8142046449275, 7795.376369890395, 8133.959330203429, 8667.0, 9047.638094476279, 4054.716169868081, 4144.026153853842, 4147.937780933288, 4149.37759336102, 4151.045259590251, 5259.658122222043, 5345.064613692588, 5347.064263753828, 5375.543078838343, 5383.865403364869, 1037.6108959140322, 1050.3277902142636, 1062.888396718349, 1063.8616979792732, 1065.3607835298915, 681.3969636871306, 701.0920857489461, 710.0343532795395, 710.6967312920215, 711.4201925430757, 11670.766584668429, 12039.036877049815, 12169.2698438094, 12487.250764954131, 13220.801687974688, 686.087503620184, 687.9896801547981, 698.0471656189266, 708.3447810775012, 709.8509313044318, 5730.226419433407, 5737.139429085587, 6381.329960354189, 6439.098526206335, 6447.709853056624, 107913.0, 108128.0, 110165.0, 114892.0, 116788.41605791917, 95975.52012239894, 100839.0, 101311.0, 101706.0, 105042.0, 85785.57107214548, 85869.0, 86476.5676171615, 87191.56404218065, 87257.56371218231, 12188.756224875275, 12319.815202772144, 13041.804372934224, 13103.868961310265, 13520.661983450493, 39304.0, 39780.6076787311, 40768.18463630651, 41205.1758964825, 41659.541916032795, 69562.30437695558, 71554.28445715684, 71674.64162679153, 72429.27570724436, 75915.62042189753, 19546.413607591796, 19603.45155129824, 19654.0, 19720.901395492932, 19779.703304450733, 20947.581048379252, 21705.674414884106, 22207.0, 22453.21413750576, 22548.323550293517, 18830.435086947415, 19280.807191928463, 19296.8070319295, 19382.61234775325, 19605.215791368184, 16624.251908663897, 16976.66046679035, 17053.744193837352, 17159.7426038607, 17715.645687086442, 17803.19885605125, 17804.287828486715, 18211.54471138232, 18961.810381896004, 19711.112999914752, 12891.226526408445, 12934.029947753768, 13521.323933803074, 13530.323483825967, 13905.721885562434, 14718.77921831152, 15170.317335719697, 15262.618434538781, 15477.148756818484, 15704.685906281582], "value": 9402.192351486983, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 102.0, 107.0, 110.0, 109.0, 108.0, 101.0, 108.0, 109.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 143.0, 173.0, 119.0, 141.0, 141.0, 119.0, 165.0, 116.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 163.0, 162.0, 164.0, 164.0, 175.0, 171.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 109.0, 78.0, 86.0, 77.0, 91.0, 99.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 130.0, 79.0, 79.0, 79.0, 124.0, 79.0, 79.0, 126.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 115.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0, 149.0, 151.0, 149.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 100.0, 93.0, 94.0, 93.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 54.0, 55.0, 54.0, 54.0, 61.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 53.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 76.0, 93.0, 77.0, 77.0, 78.0, 79.0, 79.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 132.0, 128.0, 143.0, 127.0, 124.0, 128.0, 122.0, 172.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 179.0, 181.0, 175.0, 180.0, 177.0, 184.0, 171.0, 177.0, 175.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 67.0, 69.0, 76.0, 80.0, 68.0, 67.0, 78.0], "value": 71.7, "unit": "score"}]}]} 04:10:37 INFO - Return code: 0 04:10:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:37 INFO - # TBPL SUCCESS # 04:10:37 INFO - Running post-action listener: _package_coverage_data 04:10:37 INFO - Running post-action listener: _resource_record_post_action 04:10:37 INFO - [mozharness: 2017-08-14 11:10:37.124271Z] Finished run-tests step (success) 04:10:37 INFO - Running post-run listener: _resource_record_post_run 04:10:37 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 5746688; Write bytes: 429916160; Read time: 2964; Write time: 345980 04:10:37 INFO - TinderboxPrint: CPU usage
13.1% 04:10:37 INFO - TinderboxPrint: I/O read bytes / time
5,746,688 / 2,964 04:10:37 INFO - TinderboxPrint: I/O write bytes / time
429,916,160 / 345,980 04:10:37 INFO - TinderboxPrint: CPU idle
8,271.0 (86.9%) 04:10:37 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 04:10:37 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 124276736; Read time: 108; Write time: 67480 04:10:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:10:37 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 3608576; Write bytes: 216637440; Read time: 2272; Write time: 188064 04:10:37 INFO - Running post-run listener: _upload_blobber_files 04:10:37 INFO - Blob upload gear active. 04:10:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:37 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 04:10:37 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:10:37 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:10:38 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:44 INFO - (blobuploader) - INFO - Done attempting. 04:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:45 INFO - (blobuploader) - INFO - Done attempting. 04:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:46 INFO - (blobuploader) - INFO - Done attempting. 04:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:47 INFO - (blobuploader) - INFO - Done attempting. 04:10:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:47 INFO - Return code: 0 04:10:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12383f61fedbd0784d4ed72b0148ab5ed7dc58516e6bcc8bb8a68618da2191dce8d803e67c9b21450f2355cdacb7fa56867edc2abe61c1f81fd61c67f7dbd192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/822f8ff0a0fb717b187a2dbf5e8db33a50f8ea0b86f2e04d3b66ae6c041af9a93865b733a90c59735b8163530d82f4541c0497a145501e969da3372ee59ad9ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd70302f71266e079ceb021338ae285cd58c5dbc2b12bd1992ebe76bd3bdc8f70b6f630fde469ec98549552a00b0a831146b64dee9f7b2d24b0dab1b8663af7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca13bf683741dc7e9a0c3abe31dfeaa341ec48427c56ea234dcbf6ea42068e0f9aedf59fc4ba6f1bc740bb29d86d0026f5455ff33840b8ebd8e4f25f917c22a"} 04:10:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:47 INFO - Contents: 04:10:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12383f61fedbd0784d4ed72b0148ab5ed7dc58516e6bcc8bb8a68618da2191dce8d803e67c9b21450f2355cdacb7fa56867edc2abe61c1f81fd61c67f7dbd192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/822f8ff0a0fb717b187a2dbf5e8db33a50f8ea0b86f2e04d3b66ae6c041af9a93865b733a90c59735b8163530d82f4541c0497a145501e969da3372ee59ad9ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd70302f71266e079ceb021338ae285cd58c5dbc2b12bd1992ebe76bd3bdc8f70b6f630fde469ec98549552a00b0a831146b64dee9f7b2d24b0dab1b8663af7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca13bf683741dc7e9a0c3abe31dfeaa341ec48427c56ea234dcbf6ea42068e0f9aedf59fc4ba6f1bc740bb29d86d0026f5455ff33840b8ebd8e4f25f917c22a"} 04:10:47 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:47 INFO - Copying logs to upload dir... 04:10:47 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.898908 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-14 04:10:46.993215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:46.996263) ========= 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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 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-Non-PGO/sha512/12383f61fedbd0784d4ed72b0148ab5ed7dc58516e6bcc8bb8a68618da2191dce8d803e67c9b21450f2355cdacb7fa56867edc2abe61c1f81fd61c67f7dbd192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/822f8ff0a0fb717b187a2dbf5e8db33a50f8ea0b86f2e04d3b66ae6c041af9a93865b733a90c59735b8163530d82f4541c0497a145501e969da3372ee59ad9ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd70302f71266e079ceb021338ae285cd58c5dbc2b12bd1992ebe76bd3bdc8f70b6f630fde469ec98549552a00b0a831146b64dee9f7b2d24b0dab1b8663af7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca13bf683741dc7e9a0c3abe31dfeaa341ec48427c56ea234dcbf6ea42068e0f9aedf59fc4ba6f1bc740bb29d86d0026f5455ff33840b8ebd8e4f25f917c22a"} build_url:https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12383f61fedbd0784d4ed72b0148ab5ed7dc58516e6bcc8bb8a68618da2191dce8d803e67c9b21450f2355cdacb7fa56867edc2abe61c1f81fd61c67f7dbd192", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/822f8ff0a0fb717b187a2dbf5e8db33a50f8ea0b86f2e04d3b66ae6c041af9a93865b733a90c59735b8163530d82f4541c0497a145501e969da3372ee59ad9ad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd70302f71266e079ceb021338ae285cd58c5dbc2b12bd1992ebe76bd3bdc8f70b6f630fde469ec98549552a00b0a831146b64dee9f7b2d24b0dab1b8663af7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ca13bf683741dc7e9a0c3abe31dfeaa341ec48427c56ea234dcbf6ea42068e0f9aedf59fc4ba6f1bc740bb29d86d0026f5455ff33840b8ebd8e4f25f917c22a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:47.020951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:47.021281) ========= 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=31acecf42b6a79ec49471d4a000001bb-1502698092.683727-1589719806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:10:47.102969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:10:47.103279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:10:47.103586) ========= ========= Total master_lag: 0.28 =========