builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1502727591.3 results: success (0) revision: 32c6671592f98604fe929e86f2a1d52a34b52692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:51.304756) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:51.305149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:51.305418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:51.658497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:51.658811) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 09:19:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-08-14 09:19:52 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.319399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.003107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.003404) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014426 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.070774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.071077) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 32c6671592f98604fe929e86f2a1d52a34b52692 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 32c6671592f98604fe929e86f2a1d52a34b52692 --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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 09:19:53,004 truncating revision to first 12 chars 2017-08-14 09:19:53,004 Setting DEBUG logging. 2017-08-14 09:19:53,004 attempt 1/10 2017-08-14 09:19:53,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/32c6671592f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 09:19:53,306 unpacking tar archive at: mozilla-beta-32c6671592f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.740116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.740394) ========= script_repo_revision: 32c6671592f98604fe929e86f2a1d52a34b52692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.740772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.741030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 09:19:52.756148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-14 09:19:52.756509) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:53 INFO - MultiFileLogger online at 20170814 09:19:53 in /builds/slave/test 09:19:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 09:19:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:53 INFO - {'append_to_log': False, 09:19:53 INFO - 'base_work_dir': '/builds/slave/test', 09:19:53 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:19:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:53 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:19:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:53 INFO - 'code_coverage': False, 09:19:53 INFO - 'config_files': ('talos/linux_config.py',), 09:19:53 INFO - 'default_actions': ('clobber', 09:19:53 INFO - 'read-buildbot-config', 09:19:53 INFO - 'download-and-extract', 09:19:53 INFO - 'populate-webroot', 09:19:53 INFO - 'create-virtualenv', 09:19:53 INFO - 'install', 09:19:53 INFO - 'setup-mitmproxy', 09:19:53 INFO - 'run-tests'), 09:19:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:53 INFO - 'disable_ccov_upload': False, 09:19:53 INFO - 'download_minidump_stackwalk': True, 09:19:53 INFO - 'download_symbols': 'ondemand', 09:19:53 INFO - 'enable_stylo': False, 09:19:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:53 INFO - 'gecko_profile': False, 09:19:53 INFO - 'gecko_profile_interval': 0, 09:19:53 INFO - 'installer_path': 'installer.exe', 09:19:53 INFO - 'log_level': 'info', 09:19:53 INFO - 'log_name': 'talos', 09:19:53 INFO - 'log_to_console': True, 09:19:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:53 INFO - 'opt_config_files': (), 09:19:53 INFO - 'pip_index': False, 09:19:53 INFO - 'suite': 'dromaeojs-e10s', 09:19:53 INFO - 'system_bits': '32', 09:19:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:53 INFO - 'title': 'talos-linux64-ix-075', 09:19:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:53 INFO - 'use_talos_json': True, 09:19:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:53 INFO - 'work_dir': 'build'} 09:19:53 INFO - [mozharness: 2017-08-14 16:19:53.798598Z] Running clobber step. 09:19:53 INFO - Running pre-action listener: _resource_record_pre_action 09:19:53 INFO - Running main action method: clobber 09:19:53 INFO - rmtree: /builds/slave/test/build 09:19:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:54 INFO - Running post-action listener: _resource_record_post_action 09:19:54 INFO - [mozharness: 2017-08-14 16:19:54.825545Z] Finished clobber step (success) 09:19:54 INFO - [mozharness: 2017-08-14 16:19:54.825648Z] Running read-buildbot-config step. 09:19:54 INFO - Running pre-action listener: _resource_record_pre_action 09:19:54 INFO - Running main action method: read_buildbot_config 09:19:54 INFO - Using buildbot properties: 09:19:54 INFO - { 09:19:54 INFO - "project": "", 09:19:54 INFO - "product": "firefox", 09:19:54 INFO - "who": "jlorenzo@mozilla.com", 09:19:54 INFO - "installer_path": "public/build/target.tar.bz2", 09:19:54 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:19:54 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:19:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:19:54 INFO - "stage_platform": "linux64", 09:19:54 INFO - "basedir": "/builds/slave/test", 09:19:54 INFO - "buildnumber": 49, 09:19:54 INFO - "platform": "ubuntu64_hw", 09:19:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:19:54 INFO - "slavebuilddir": "test", 09:19:54 INFO - "taskId": "Sy-1ARcRTva8laomkxIa4Q", 09:19:54 INFO - "branch": "mozilla-beta", 09:19:54 INFO - "script_repo_revision": "production", 09:19:54 INFO - "revision": "32c6671592f98604fe929e86f2a1d52a34b52692", 09:19:54 INFO - "slavename": "talos-linux64-ix-075", 09:19:54 INFO - "repo_path": "releases/mozilla-beta" 09:19:54 INFO - } 09:19:54 INFO - Finding installer, test and symbols from parent task. 09:19:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sy-1ARcRTva8laomkxIa4Q'}, attempt #1 09:19:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sy-1ARcRTva8laomkxIa4Q'}, attempt #1 09:19:55 INFO - Task dependencies: M3MP4v6GSyyha90KOKlUGA 09:19:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA'}, attempt #1 09:19:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 09:19:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.test_packages.json 09:19:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.crashreporter-symbols.zip 09:19:56 INFO - Running post-action listener: _resource_record_post_action 09:19:56 INFO - [mozharness: 2017-08-14 16:19:56.175683Z] Finished read-buildbot-config step (success) 09:19:56 INFO - [mozharness: 2017-08-14 16:19:56.175906Z] Running download-and-extract step. 09:19:56 INFO - Running pre-action listener: _resource_record_pre_action 09:19:56 INFO - Running main action method: download_and_extract 09:19:56 INFO - mkdir: /builds/slave/test/build/tests 09:19:56 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')]} 09:19:56 INFO - trying https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.test_packages.json 09:19:56 INFO - Downloading https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:56 INFO - Downloaded 989 bytes. 09:19:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:56 INFO - Using the following test package requirements: 09:19:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:56 INFO - u'common': [u'target.common.tests.zip'], 09:19:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:56 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:56 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:56 INFO - u'target.web-platform.tests.tar.gz'], 09:19:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:19:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip 09:19:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:56 INFO - Fetch https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip into memory 09:19:59 INFO - Content-Length response header: 72820836 09:19:59 INFO - Bytes received: 72820836 09:20:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:20:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip 09:20:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:20:10 INFO - Fetch https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.common.tests.zip into memory 09:20:12 INFO - Content-Length response header: 72820836 09:20:12 INFO - Bytes received: 72820836 09:20:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.talos.tests.zip 09:20:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:20:24 INFO - Fetch https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.talos.tests.zip into memory 09:20:25 INFO - Content-Length response header: 14496472 09:20:25 INFO - Bytes received: 14496472 09:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:25 INFO - trying https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 09:20:25 INFO - Downloading https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:20:28 INFO - Downloaded 53699460 bytes. 09:20:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 09:20:28 INFO - mkdir: /builds/slave/test/properties 09:20:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:28 INFO - Contents: 09:20:28 INFO - build_url:https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 09:20:28 INFO - Running post-action listener: _resource_record_post_action 09:20:28 INFO - Running post-action listener: set_extra_try_arguments 09:20:28 INFO - [mozharness: 2017-08-14 16:20:28.858572Z] Finished download-and-extract step (success) 09:20:28 INFO - [mozharness: 2017-08-14 16:20:28.858802Z] Running populate-webroot step. 09:20:28 INFO - Running pre-action listener: _resource_record_pre_action 09:20:28 INFO - Running main action method: populate_webroot 09:20:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:20:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:20:28 INFO - 'tests': ['damp', 'tps']}, 09:20:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:20:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:20:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:20:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:28 INFO - 'ts_paint', 09:20:28 INFO - 'tpaint', 09:20:28 INFO - 'sessionrestore', 09:20:28 INFO - 'sessionrestore_many_windows', 09:20:28 INFO - 'sessionrestore_no_auto_restore', 09:20:28 INFO - 'tabpaint']}, 09:20:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:20:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:20:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:20:28 INFO - 'talos_options': ['--mitmproxy', 09:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:20:28 INFO - '--firstNonBlankPaint'], 09:20:28 INFO - 'tests': ['quantum_pageload_google', 09:20:28 INFO - 'quantum_pageload_youtube', 09:20:28 INFO - 'quantum_pageload_amazon', 09:20:28 INFO - 'quantum_pageload_facebook']}, 09:20:28 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:20:28 INFO - 'talos_options': ['--stylo', 09:20:28 INFO - '--mitmproxy', 09:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:20:28 INFO - '--firstNonBlankPaint'], 09:20:28 INFO - 'tests': ['quantum_pageload_google', 09:20:28 INFO - 'quantum_pageload_youtube', 09:20:28 INFO - 'quantum_pageload_amazon', 09:20:28 INFO - 'quantum_pageload_facebook']}, 09:20:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:28 INFO - 'tsvgr_opacity', 09:20:28 INFO - 'tart', 09:20:28 INFO - 'tscrollx', 09:20:28 INFO - 'cart', 09:20:28 INFO - 'tsvg_static']}, 09:20:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:20:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:20:28 INFO - 'talos_options': ['--stylo', 09:20:28 INFO - '--stylo-threads=1', 09:20:28 INFO - '--mitmproxy', 09:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:20:28 INFO - '--firstNonBlankPaint'], 09:20:28 INFO - 'tests': ['tp6_google', 09:20:28 INFO - 'tp6_youtube', 09:20:28 INFO - 'tp6_amazon', 09:20:28 INFO - 'tp6_facebook']}, 09:20:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:20:28 INFO - 'talos_options': ['--xperf_path', 09:20:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:28 INFO - 'tests': ['tp5n']}}} 09:20:28 INFO - Running post-action listener: _resource_record_post_action 09:20:28 INFO - [mozharness: 2017-08-14 16:20:28.876812Z] Finished populate-webroot step (success) 09:20:28 INFO - [mozharness: 2017-08-14 16:20:28.876903Z] Running create-virtualenv step. 09:20:28 INFO - Running pre-action listener: _resource_record_pre_action 09:20:28 INFO - Running main action method: create_virtualenv 09:20:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:28 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 09:20:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:20:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:28 INFO - Using real prefix '/usr' 09:20:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:31 INFO - Installing pip.................done. 09:20:31 INFO - Return code: 0 09:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:20:31 INFO - Reading from file tmpfile_stdout 09:20:31 INFO - Output received: 09:20:31 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) 09:20:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:31 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:31 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 09:20:31 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 09:20:31 INFO - Using env: {'DISPLAY': ':0', 09:20:31 INFO - 'HOME': '/home/cltbld', 09:20:31 INFO - 'LANG': 'en_US.UTF-8', 09:20:31 INFO - 'LANGUAGE': 'en_US:en', 09:20:31 INFO - 'LOGNAME': 'cltbld', 09:20:31 INFO - 'MAIL': '/var/mail/cltbld', 09:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:31 INFO - 'MOZ_NO_REMOTE': '1', 09:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:31 INFO - 'NO_EM_RESTART': '1', 09:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:31 INFO - 'PWD': '/builds/slave/test', 09:20:31 INFO - 'SHELL': '/bin/bash', 09:20:31 INFO - 'SHLVL': '1', 09:20:31 INFO - 'TERM': 'linux', 09:20:31 INFO - 'TMOUT': '86400', 09:20:31 INFO - 'USER': 'cltbld', 09:20:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:31 INFO - '_': '/tools/buildbot/bin/python'} 09:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:31 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 09:20:31 INFO - Cleaning up... 09:20:31 INFO - Return code: 0 09:20:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:31 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:31 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 09:20:31 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 09:20:31 INFO - Using env: {'DISPLAY': ':0', 09:20:31 INFO - 'HOME': '/home/cltbld', 09:20:31 INFO - 'LANG': 'en_US.UTF-8', 09:20:31 INFO - 'LANGUAGE': 'en_US:en', 09:20:31 INFO - 'LOGNAME': 'cltbld', 09:20:31 INFO - 'MAIL': '/var/mail/cltbld', 09:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:31 INFO - 'MOZ_NO_REMOTE': '1', 09:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:31 INFO - 'NO_EM_RESTART': '1', 09:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:31 INFO - 'PWD': '/builds/slave/test', 09:20:31 INFO - 'SHELL': '/bin/bash', 09:20:31 INFO - 'SHLVL': '1', 09:20:31 INFO - 'TERM': 'linux', 09:20:31 INFO - 'TMOUT': '86400', 09:20:31 INFO - 'USER': 'cltbld', 09:20:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:31 INFO - '_': '/tools/buildbot/bin/python'} 09:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:32 INFO - Downloading/unpacking psutil>=3.1.1 09:20: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 09:20: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 09:20: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 09:20: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 09:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:33 INFO - Installing collected packages: psutil 09:20:33 INFO - Running setup.py install for psutil 09:20:33 INFO - building 'psutil._psutil_linux' extension 09:20:33 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 09:20:33 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 09:20:33 INFO - building 'psutil._psutil_posix' extension 09:20:33 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 09:20:33 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 09:20:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:33 INFO - Successfully installed psutil 09:20:33 INFO - Cleaning up... 09:20:33 INFO - Return code: 0 09:20:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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')]} 09:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:33 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:33 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 09:20:33 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 09:20:33 INFO - Using env: {'DISPLAY': ':0', 09:20:33 INFO - 'HOME': '/home/cltbld', 09:20:33 INFO - 'LANG': 'en_US.UTF-8', 09:20:33 INFO - 'LANGUAGE': 'en_US:en', 09:20:33 INFO - 'LOGNAME': 'cltbld', 09:20:33 INFO - 'MAIL': '/var/mail/cltbld', 09:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:33 INFO - 'MOZ_NO_REMOTE': '1', 09:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:33 INFO - 'NO_EM_RESTART': '1', 09:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:33 INFO - 'PWD': '/builds/slave/test', 09:20:33 INFO - 'SHELL': '/bin/bash', 09:20:33 INFO - 'SHLVL': '1', 09:20:33 INFO - 'TERM': 'linux', 09:20:33 INFO - 'TMOUT': '86400', 09:20:33 INFO - 'USER': 'cltbld', 09:20:33 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:33 INFO - '_': '/tools/buildbot/bin/python'} 09:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20:34 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 09:20:34 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 09:20:34 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 09:20:34 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 09:20:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:20:35 INFO - Installing collected packages: mozsystemmonitor 09:20:35 INFO - Running setup.py install for mozsystemmonitor 09:20:35 INFO - Successfully installed mozsystemmonitor 09:20:35 INFO - Cleaning up... 09:20:35 INFO - Return code: 0 09:20:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20:35 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')]} 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:35 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')]} 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:35 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:35 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 09:20:35 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 09:20:35 INFO - Using env: {'DISPLAY': ':0', 09:20:35 INFO - 'HOME': '/home/cltbld', 09:20:35 INFO - 'LANG': 'en_US.UTF-8', 09:20:35 INFO - 'LANGUAGE': 'en_US:en', 09:20:35 INFO - 'LOGNAME': 'cltbld', 09:20:35 INFO - 'MAIL': '/var/mail/cltbld', 09:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:35 INFO - 'MOZ_NO_REMOTE': '1', 09:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:35 INFO - 'NO_EM_RESTART': '1', 09:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:35 INFO - 'PWD': '/builds/slave/test', 09:20:35 INFO - 'SHELL': '/bin/bash', 09:20:35 INFO - 'SHLVL': '1', 09:20:35 INFO - 'TERM': 'linux', 09:20:35 INFO - 'TMOUT': '86400', 09:20:35 INFO - 'USER': 'cltbld', 09:20:35 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:35 INFO - '_': '/tools/buildbot/bin/python'} 09:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:35 INFO - Downloading/unpacking jsonschema==2.5.1 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:20:36 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 09:20:36 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 09:20:36 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 09:20:36 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 09:20:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:36 INFO - warning: no files found matching '*.txt' 09:20:36 INFO - no previously-included directories found matching 'build' 09:20:36 INFO - no previously-included directories found matching 'dist' 09:20:36 INFO - no previously-included directories found matching '.git*' 09:20:36 INFO - Installing collected packages: jsonschema, functools32 09:20:36 INFO - Running setup.py install for functools32 09:20:36 INFO - warning: no files found matching '*.txt' 09:20:36 INFO - no previously-included directories found matching 'build' 09:20:36 INFO - no previously-included directories found matching 'dist' 09:20:36 INFO - no previously-included directories found matching '.git*' 09:20:36 INFO - Successfully installed jsonschema functools32 09:20:36 INFO - Cleaning up... 09:20:37 INFO - Return code: 0 09:20:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:37 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:37 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 09:20:37 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 09:20:37 INFO - Using env: {'DISPLAY': ':0', 09:20:37 INFO - 'HOME': '/home/cltbld', 09:20:37 INFO - 'LANG': 'en_US.UTF-8', 09:20:37 INFO - 'LANGUAGE': 'en_US:en', 09:20:37 INFO - 'LOGNAME': 'cltbld', 09:20:37 INFO - 'MAIL': '/var/mail/cltbld', 09:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:37 INFO - 'MOZ_NO_REMOTE': '1', 09:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:37 INFO - 'NO_EM_RESTART': '1', 09:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:37 INFO - 'PWD': '/builds/slave/test', 09:20:37 INFO - 'SHELL': '/bin/bash', 09:20:37 INFO - 'SHLVL': '1', 09:20:37 INFO - 'TERM': 'linux', 09:20:37 INFO - 'TMOUT': '86400', 09:20:37 INFO - 'USER': 'cltbld', 09:20:37 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:37 INFO - '_': '/tools/buildbot/bin/python'} 09:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:20:37 INFO - Cleaning up... 09:20:37 INFO - Return code: 0 09:20:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:37 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:37 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 09:20:37 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 09:20:37 INFO - Using env: {'DISPLAY': ':0', 09:20:37 INFO - 'HOME': '/home/cltbld', 09:20:37 INFO - 'LANG': 'en_US.UTF-8', 09:20:37 INFO - 'LANGUAGE': 'en_US:en', 09:20:37 INFO - 'LOGNAME': 'cltbld', 09:20:37 INFO - 'MAIL': '/var/mail/cltbld', 09:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:37 INFO - 'MOZ_NO_REMOTE': '1', 09:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:37 INFO - 'NO_EM_RESTART': '1', 09:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:37 INFO - 'PWD': '/builds/slave/test', 09:20:37 INFO - 'SHELL': '/bin/bash', 09:20:37 INFO - 'SHLVL': '1', 09:20:37 INFO - 'TERM': 'linux', 09:20:37 INFO - 'TMOUT': '86400', 09:20:37 INFO - 'USER': 'cltbld', 09:20:37 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:37 INFO - '_': '/tools/buildbot/bin/python'} 09:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:20: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 09:20: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 09:20: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 09:20: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 09:20:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:38 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 09:20:38 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 09:20:38 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 09:20:38 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 09:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:38 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 09:20:38 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 09:20:38 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 09:20:38 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 09:20:39 INFO - Downloading docopt-0.6.1.tar.gz 09:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:39 INFO - Running setup.py install for blobuploader 09:20:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:39 INFO - Running setup.py install for requests 09:20:39 INFO - Running setup.py install for docopt 09:20:39 INFO - Successfully installed blobuploader requests docopt 09:20:39 INFO - Cleaning up... 09:20:39 INFO - Return code: 0 09:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20: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')]} 09:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:39 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:39 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 09:20:39 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 09:20:39 INFO - Using env: {'DISPLAY': ':0', 09:20:39 INFO - 'HOME': '/home/cltbld', 09:20:39 INFO - 'LANG': 'en_US.UTF-8', 09:20:39 INFO - 'LANGUAGE': 'en_US:en', 09:20:39 INFO - 'LOGNAME': 'cltbld', 09:20:39 INFO - 'MAIL': '/var/mail/cltbld', 09:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:39 INFO - 'MOZ_NO_REMOTE': '1', 09:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:39 INFO - 'NO_EM_RESTART': '1', 09:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:39 INFO - 'PWD': '/builds/slave/test', 09:20:39 INFO - 'SHELL': '/bin/bash', 09:20:39 INFO - 'SHLVL': '1', 09:20:39 INFO - 'TERM': 'linux', 09:20:39 INFO - 'TMOUT': '86400', 09:20:39 INFO - 'USER': 'cltbld', 09:20:39 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:39 INFO - '_': '/tools/buildbot/bin/python'} 09:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:39 INFO - Running setup.py (path:/tmp/pip-yCmTfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:40 INFO - Running setup.py (path:/tmp/pip-z921qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:40 INFO - Running setup.py (path:/tmp/pip-jwXSSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:40 INFO - Running setup.py (path:/tmp/pip-Ugn91R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:40 INFO - Running setup.py (path:/tmp/pip-LuPkcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:40 INFO - Running setup.py (path:/tmp/pip-s2mt2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:40 INFO - Running setup.py (path:/tmp/pip-fAWF1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:40 INFO - Running setup.py (path:/tmp/pip-nuWLJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:40 INFO - Running setup.py (path:/tmp/pip-Mg4Kph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:40 INFO - Running setup.py (path:/tmp/pip-eqIasV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:40 INFO - Running setup.py (path:/tmp/pip-_7iTPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:40 INFO - Running setup.py (path:/tmp/pip-_7EEpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:40 INFO - Running setup.py (path:/tmp/pip-e3OQhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:40 INFO - Running setup.py (path:/tmp/pip-AdO5S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:40 INFO - Running setup.py (path:/tmp/pip-HJD1xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:41 INFO - Running setup.py (path:/tmp/pip-yg_uEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:41 INFO - Running setup.py (path:/tmp/pip-bbLH5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:41 INFO - Running setup.py install for manifestparser 09:20:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Running setup.py install for mozcrash 09:20:41 INFO - Running setup.py install for mozdebug 09:20:41 INFO - Running setup.py install for mozdevice 09:20:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Running setup.py install for mozfile 09:20:41 INFO - Running setup.py install for mozhttpd 09:20:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Running setup.py install for mozinfo 09:20:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Running setup.py install for mozInstall 09:20:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:41 INFO - Running setup.py install for mozleak 09:20:42 INFO - Running setup.py install for mozlog 09:20:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for moznetwork 09:20:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozprocess 09:20:42 INFO - Running setup.py install for mozprofile 09:20:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozrunner 09:20:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozscreenshot 09:20:42 INFO - Running setup.py install for moztest 09:20:42 INFO - Running setup.py install for mozversion 09:20:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:42 INFO - Cleaning up... 09:20:42 INFO - Return code: 0 09:20:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:42 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')]} 09:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:42 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')]} 09:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:42 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:42 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 09:20:42 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 09:20:42 INFO - Using env: {'DISPLAY': ':0', 09:20:42 INFO - 'HOME': '/home/cltbld', 09:20:42 INFO - 'LANG': 'en_US.UTF-8', 09:20:42 INFO - 'LANGUAGE': 'en_US:en', 09:20:42 INFO - 'LOGNAME': 'cltbld', 09:20:42 INFO - 'MAIL': '/var/mail/cltbld', 09:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:42 INFO - 'MOZ_NO_REMOTE': '1', 09:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:42 INFO - 'NO_EM_RESTART': '1', 09:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:42 INFO - 'PWD': '/builds/slave/test', 09:20:42 INFO - 'SHELL': '/bin/bash', 09:20:42 INFO - 'SHLVL': '1', 09:20:42 INFO - 'TERM': 'linux', 09:20:42 INFO - 'TMOUT': '86400', 09:20:42 INFO - 'USER': 'cltbld', 09:20:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:42 INFO - '_': '/tools/buildbot/bin/python'} 09:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:43 INFO - Running setup.py (path:/tmp/pip-OPlhkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:43 INFO - Running setup.py (path:/tmp/pip-FWQDg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:43 INFO - Running setup.py (path:/tmp/pip-eKuVZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:43 INFO - Running setup.py (path:/tmp/pip-Lszw9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:43 INFO - Running setup.py (path:/tmp/pip-VzNrUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:43 INFO - Running setup.py (path:/tmp/pip-YHVHzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:43 INFO - Running setup.py (path:/tmp/pip-2jk8Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:43 INFO - Running setup.py (path:/tmp/pip-Ykc4rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:43 INFO - Running setup.py (path:/tmp/pip-eMVhwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:43 INFO - Running setup.py (path:/tmp/pip-oum5Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:43 INFO - Running setup.py (path:/tmp/pip-YwpNTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:43 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)) 09:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:43 INFO - Running setup.py (path:/tmp/pip-XNfHI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:44 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)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:44 INFO - Running setup.py (path:/tmp/pip-TmDLea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:44 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)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:44 INFO - Running setup.py (path:/tmp/pip-lxLwBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:44 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)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:44 INFO - Running setup.py (path:/tmp/pip-GCvppu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:44 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)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:44 INFO - Running setup.py (path:/tmp/pip-_ZDkMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:44 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)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:44 INFO - Running setup.py (path:/tmp/pip-QK0G_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:44 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)) 09:20:44 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)) 09:20:44 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)) 09:20:44 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)) 09:20:44 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)) 09:20:44 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)) 09:20:44 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)) 09:20:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:44 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 09:20:44 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 09:20:44 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 09:20:44 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 09:20:45 INFO - Downloading blessings-1.6.tar.gz 09:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:45 INFO - Installing collected packages: blessings 09:20:45 INFO - Running setup.py install for blessings 09:20:45 INFO - Successfully installed blessings 09:20:45 INFO - Cleaning up... 09:20:45 INFO - Return code: 0 09:20:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:45 INFO - Reading from file tmpfile_stdout 09:20:45 INFO - Current package versions: 09:20:45 INFO - argparse == 1.2.1 09:20:45 INFO - blessings == 1.6 09:20:45 INFO - blobuploader == 1.2.4 09:20:45 INFO - docopt == 0.6.1 09:20:45 INFO - functools32 == 3.2.3-2 09:20:45 INFO - jsonschema == 2.5.1 09:20:45 INFO - manifestparser == 1.1 09:20:45 INFO - mozInstall == 1.13 09:20:45 INFO - mozcrash == 1.0 09:20:45 INFO - mozdebug == 0.1 09:20:45 INFO - mozdevice == 0.51 09:20:45 INFO - mozfile == 1.2 09:20:45 INFO - mozhttpd == 0.7 09:20:45 INFO - mozinfo == 0.10 09:20:45 INFO - mozleak == 0.1 09:20:45 INFO - mozlog == 3.5 09:20:45 INFO - moznetwork == 0.27 09:20:45 INFO - mozprocess == 0.25 09:20:45 INFO - mozprofile == 0.28 09:20:45 INFO - mozrunner == 6.13 09:20:45 INFO - mozscreenshot == 0.1 09:20:45 INFO - mozsystemmonitor == 0.3 09:20:45 INFO - moztest == 0.8 09:20:45 INFO - mozversion == 1.4 09:20:45 INFO - psutil == 3.1.1 09:20:45 INFO - requests == 1.2.3 09:20:45 INFO - wsgiref == 0.1.2 09:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:45 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')]} 09:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:45 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')]} 09:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:45 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:45 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 09:20:45 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 09:20:45 INFO - Using env: {'DISPLAY': ':0', 09:20:45 INFO - 'HOME': '/home/cltbld', 09:20:45 INFO - 'LANG': 'en_US.UTF-8', 09:20:45 INFO - 'LANGUAGE': 'en_US:en', 09:20:45 INFO - 'LOGNAME': 'cltbld', 09:20:45 INFO - 'MAIL': '/var/mail/cltbld', 09:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:45 INFO - 'MOZ_NO_REMOTE': '1', 09:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:45 INFO - 'NO_EM_RESTART': '1', 09:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:45 INFO - 'PWD': '/builds/slave/test', 09:20:45 INFO - 'SHELL': '/bin/bash', 09:20:45 INFO - 'SHLVL': '1', 09:20:45 INFO - 'TERM': 'linux', 09:20:45 INFO - 'TMOUT': '86400', 09:20:45 INFO - 'USER': 'cltbld', 09:20:45 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:45 INFO - '_': '/tools/buildbot/bin/python'} 09:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 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)) 09:20:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:46 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 09:20:46 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 09:20:46 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 09:20:46 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 09:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:20:47 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)) 09:20:47 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)) 09:20:47 INFO - Installing collected packages: simplejson 09:20:47 INFO - Running setup.py install for simplejson 09:20:47 INFO - building 'simplejson._speedups' extension 09:20:47 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 09:20:48 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 09:20:48 INFO - Successfully installed simplejson 09:20:48 INFO - Cleaning up... 09:20:48 INFO - Return code: 0 09:20:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:48 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')]} 09:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:48 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')]} 09:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:48 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 0x14a71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1673a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1816eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', '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 09:20:48 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 09:20:48 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 09:20:48 INFO - Using env: {'DISPLAY': ':0', 09:20:48 INFO - 'HOME': '/home/cltbld', 09:20:48 INFO - 'LANG': 'en_US.UTF-8', 09:20:48 INFO - 'LANGUAGE': 'en_US:en', 09:20:48 INFO - 'LOGNAME': 'cltbld', 09:20:48 INFO - 'MAIL': '/var/mail/cltbld', 09:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:48 INFO - 'MOZ_NO_REMOTE': '1', 09:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:48 INFO - 'NO_EM_RESTART': '1', 09:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:48 INFO - 'PWD': '/builds/slave/test', 09:20:48 INFO - 'SHELL': '/bin/bash', 09:20:48 INFO - 'SHLVL': '1', 09:20:48 INFO - 'TERM': 'linux', 09:20:48 INFO - 'TMOUT': '86400', 09:20:48 INFO - 'USER': 'cltbld', 09:20:48 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:48 INFO - '_': '/tools/buildbot/bin/python'} 09:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:48 INFO - Cleaning up... 09:20:48 INFO - Return code: 0 09:20:48 INFO - Running post-action listener: _resource_record_post_action 09:20:48 INFO - Running post-action listener: _start_resource_monitoring 09:20:48 INFO - Starting resource monitoring. 09:20:48 INFO - [mozharness: 2017-08-14 16:20:48.703720Z] Finished create-virtualenv step (success) 09:20:48 INFO - [mozharness: 2017-08-14 16:20:48.704224Z] Running install step. 09:20:48 INFO - Running pre-action listener: _resource_record_pre_action 09:20:48 INFO - Running main action method: install 09:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:48 INFO - Reading from file tmpfile_stdout 09:20:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:49 INFO - Reading from file tmpfile_stdout 09:20:49 INFO - Output received: 09:20:49 INFO - Usage: mozinstall [options] installer 09:20:49 INFO - Options: 09:20:49 INFO - -h, --help show this help message and exit 09:20:49 INFO - -d DEST, --destination=DEST 09:20:49 INFO - Directory to install application into. [default: 09:20:49 INFO - "/builds/slave/test"] 09:20:49 INFO - --app=APP Application being installed. [default: firefox] 09:20:49 INFO - mkdir: /builds/slave/test/build/application 09:20:49 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'] 09:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:21:03 INFO - Reading from file tmpfile_stdout 09:21:03 INFO - Output received: 09:21:03 INFO - /builds/slave/test/build/application/firefox/firefox 09:21:03 INFO - Running post-action listener: _resource_record_post_action 09:21:03 INFO - [mozharness: 2017-08-14 16:21:03.785957Z] Finished install step (success) 09:21:03 INFO - [mozharness: 2017-08-14 16:21:03.786219Z] Running setup-mitmproxy step. 09:21:03 INFO - Running pre-action listener: _resource_record_pre_action 09:21:03 INFO - Running main action method: setup_mitmproxy 09:21:03 INFO - Skipping: mitmproxy is not required 09:21:03 INFO - Running post-action listener: _resource_record_post_action 09:21:03 INFO - [mozharness: 2017-08-14 16:21:03.787352Z] Finished setup-mitmproxy step (success) 09:21:03 INFO - [mozharness: 2017-08-14 16:21:03.787574Z] Running run-tests step. 09:21:03 INFO - Running pre-action listener: _resource_record_pre_action 09:21:03 INFO - Running pre-action listener: _set_gcov_prefix 09:21:03 INFO - Running main action method: run_tests 09:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:03 INFO - Python 2.7.3 09:21:03 INFO - Return code: 0 09:21:03 INFO - grabbing minidump binary from tooltool 09:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:03 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 0x1814050>, '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 0x1814f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18153e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:03 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 09:21:03 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 09:21:03 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 09:21:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:03 INFO - Return code: 0 09:21:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:21:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:03 INFO - ENV: RUST_BACKTRACE is now 1 09:21:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:21:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 09:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 09:21:03 INFO - Using env: {'DISPLAY': ':0', 09:21:03 INFO - 'HOME': '/home/cltbld', 09:21:03 INFO - 'LANG': 'en_US.UTF-8', 09:21:03 INFO - 'LANGUAGE': 'en_US:en', 09:21:03 INFO - 'LOGNAME': 'cltbld', 09:21:03 INFO - 'MAIL': '/var/mail/cltbld', 09:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:03 INFO - 'MOZ_NO_REMOTE': '1', 09:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:03 INFO - 'NO_EM_RESTART': '1', 09:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:03 INFO - 'PWD': '/builds/slave/test', 09:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:03 INFO - 'RUST_BACKTRACE': '1', 09:21:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:21:03 INFO - 'SHELL': '/bin/bash', 09:21:03 INFO - 'SHLVL': '1', 09:21:03 INFO - 'TERM': 'linux', 09:21:03 INFO - 'TMOUT': '86400', 09:21:03 INFO - 'USER': 'cltbld', 09:21:03 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281', 09:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:03 INFO - '_': '/tools/buildbot/bin/python'} 09:21:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 09:21:04 INFO - mozversion application_buildid: 20170814150858 09:21:04 INFO - mozversion application_changeset: 32c6671592f98604fe929e86f2a1d52a34b52692 09:21:04 INFO - mozversion application_display_name: Firefox 09:21:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:04 INFO - mozversion application_name: Firefox 09:21:04 INFO - mozversion application_remotingname: firefox 09:21:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:21:04 INFO - mozversion application_vendor: Mozilla 09:21:04 INFO - mozversion application_version: 56.0 09:21:04 INFO - mozversion platform_buildid: 20170814150858 09:21:04 INFO - mozversion platform_changeset: 32c6671592f98604fe929e86f2a1d52a34b52692 09:21:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:21:04 INFO - mozversion platform_version: 56.0 09:21:04 INFO - using testdate: 1502727664 09:21:04 INFO - actual date: 1502727664 09:21:04 INFO - starting webserver on 'localhost:36238' 09:21:04 INFO - SUITE-START | Running 2 tests 09:21:04 INFO - TEST-START | dromaeo_css 09:21:04 INFO - Initialising browser for dromaeo_css test... 09:21:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36238/getInfo.html -profile /tmp/tmpIEtaWy/profile 09:21:04 INFO - TEST-INFO | started process 29664 (/builds/slave/test/build/application/firefox/firefox http://localhost:36238/getInfo.html) 09:21:09 INFO - TEST-INFO | 29664: exit 0 09:21:10 INFO - Browser initialized. 09:21:10 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:10 INFO - TEST-INFO | started process 29828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIEtaWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:10 INFO - PID 29828 | 1502727670401 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 09:21:21 INFO - PID 29828 | RSS: Main: 139386880 09:21:21 INFO - PID 29828 | 09:24:18 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36238/tests/dromaeo/cssquery-ext.html) 09:24:20 INFO - PID 29828 | RSS: Main: 149295104 09:24:20 INFO - PID 29828 | 09:27:21 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-ext.html (next: http://localhost:36238/tests/dromaeo/cssquery-jquery.html) 09:27:22 INFO - PID 29828 | RSS: Main: 147644416 09:27:22 INFO - PID 29828 | 09:30:23 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36238/tests/dromaeo/cssquery-mootools.html) 09:30:24 INFO - PID 29828 | RSS: Main: 148238336 09:30:24 INFO - PID 29828 | 09:33:26 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36238/tests/dromaeo/cssquery-prototype.html) 09:33:26 INFO - PID 29828 | RSS: Main: 149368832 09:33:26 INFO - PID 29828 | 09:36:29 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36238/tests/dromaeo/cssquery-yui.html) 09:36:30 INFO - PID 29828 | RSS: Main: 152252416 09:36:30 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | Cycle 1(1): loaded http://localhost:36238/tests/dromaeo/cssquery-yui.html (next: http://localhost:36238/tests/dromaeo/cssquery-dojo.html) 09:39:32 INFO - PID 29828 | RSS: Main: 155189248 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | __start_tp_report 09:39:32 INFO - PID 29828 | _x_x_mozilla_page_load 09:39:32 INFO - PID 29828 | _x_x_mozilla_page_load_details 09:39:32 INFO - PID 29828 | |i|pagename|runs| 09:39:32 INFO - PID 29828 | |0;dojo.html;3473.426884564044;3523.154442933696;3537.3809583322914;3614.8915532534024;3632.5096112024867;6286.9685651571735;6396.040593910916;6402.487800975922;6424.61452312861;6439.581427207228;6345.809625711225;6384.648844313561;6426.196725409324;6466.773662921799;6490.415862572368;5461.262729531522;5566.638168519054;5609.635373700697;5615.634983726065;5677.460641239086;5542.362628297757;5546.140348246028;5624.325080990287;5638.577106716992;5644.943550564483;5612.017896868052;5632.859178520529;5636.859078523029;5683.801066962657;5704.429557044304;5433.266509021271;5611.607187496877;5646.745896434671;5672.546196304327;5688.488036076773;5480.287562616874;5533.391326954032;5548.528375088123;5552.91670624941;5572.3034620672415;6249.78125765596;6251.749930002795;6291.653959032252;6307;6357.618542887395;6881.002254673044;6886.586804791728;6962.373386395248;6969.965150174267;6984.930150698529;6808.114945057111;6887.483438742114;6887.655617219119;6987.091678081817;7044.894326585106;6495.805125846232;6514.218293804774;6573.93426065738;6580.76967306142;6584.209894812653;6986.16166060076;7091.3972312353;7093.467989900778;7125.465590080765;7217.170025447036;6779.49153813466;6815.829604259933;6876.965615171892;6879.449644028566;6886.621235831977;6943.166819981635;6979.3718565328345;7005.92994070063;7021.192562855234;7026.473014523931;6664.83337916556;6829.043933849265;6840.9657951710915;6912.861742765116;6925.168979722364;6791.796246112624;6858.485613579001;6894.724211031603;6946.444284457231;6962.094927659473;5112.130937740593;5156.097682905476;5157.871053223625;5161.948380516222;5175.508326708957;4498.707584007029;4594.1271158479785;4600.42494688164;4603.033362993742;4628.097520983443;6303.495720342362;6402.295747467775;6403.231612206565;6565.310642382577;6645.368689974444;6819.283975182633;6895.448364130857;6911.308869113049;6965.268646792014;7026.227115017344;6617.437517810944;6659.933400666028;6665.400113989765;6671.166104236971;6700.731970721214;5764.510016648632;5845.461485114491;5916.585838991229;5917;5917.911231331534;7000.789976300719;7115.324044215791;7127.394171495481;7211.999999999895;7301.525400848928;6969.303069693092;6990.440764738707;6996.580205187705;6999.895001574879;7009.088818453569;7160.749373771893;7254.782356529313;7259.092613423322;7267.527610705287;7271.563706177646;6911.7926462206215;6956.895646565406;6966.616836073862;6971.024056632177;6972.1284839395075;7004.859902801813;7011.26381729911;7013.473989450709;7078.044463997295;7090.361867431956;6564.540482166202;6633.336666333328;6639.236487803964;6653.833654158685;6753.493487988322;6698.363655452724;6705.698243578953;6727.93272067273;6728.259891412039;6731.259561448334;6636.469082473294;6690.665466726741;6712.563683360566;6723.394894459522;6741.1910570731825;6800.217974932748;6812.14848143982;6841.213260475109;6868.7252509901045;6891.793246202622;6414.486841052798;6517.771877984437;6625.370589793962;6626.105475760711;6716 09:39:32 INFO - PID 29828 | |1;ext.html;883.3286702106398;925.2505470568844;959.2517836087852;978.5058545434555;985.4579981010447;41355.58644413555;42108.78945605276;42235;42283.36574951378;42285.15429691404;39056.60943390565;39224.41163382552;39319.60680393195;39350.40974385387;39409.40885886707;7094.680739366715;7198.388137008361;7198.7480438184675;7199.136103667567;7202.387797037232;7093.538919970211;7109.8933515997305;7174.8565028699395;7176.641167941608;7179.856402871966;7721.691132354699;7907.2488113629115;7918.366530677532;7919.802004949865;7921.287084162424;7821.413393995473;7855.13593504714;7858.882116768253;7859.410544209179;7867.960660196691;7725.729599464048;7727.536347819148;7770.261825126604;7775.766726998199;7811.531308121531;39983;40009.199816003806;40109.398359024635;40274.798626006974;40314;3715.851365945359;3779.093017675738;3783.886483405502;3784.526934133233;3785.413260944558;32204;32414.83792581022;32467.350652987043;32470.837645811855;32566.348673026645;5014.949850501484;5163.432022477525;5184.377874655028;5189.792408303663;5213.296205012351;216441;216974;218150;219561;223407.8829605858;51333.743331283105;52129.47870521322;52226.477735222164;52240;52305;54793.452065478836;54807;55097.17354239689;55107.17339239915;55176.172357414674;16734.079625620707;16798.748018779726;16857.325706971827;16865.325386984383;17016.744748828776;13801;13927.303634818218;13930;13935.860641393456;13966.092204006707;15243.161626110448;15303.770443443358;15429.074255544703;15439.614009649624;15546.067235965653;6035.275766907999;6123.693815309217;6137.263528376534;6198.566100372931;6204.410580994799;1115.5872327238974;1120.4285814234636;1138.7494751154732;1139.9031082358092;1158.9826152607718;25850.35374115662;26229.868850656007;26362.604560931602;26392.60411093835;26428.8678556606;1229.624964385871;1229.9077569182168;1250.8874201321926;1254.667513109027;1257.7610254051701;13373.866261337262;13712;13779.381917435656;14148.292585370691;14215.36030878613;275428;275818;277309;278333;278560;56388.43611563914;56770.71614641901;56891.715541422025;57145.714271429206;57216;1539.5073576455427;1551.8137823461257;1574.5748647865012;1574.8109977623758;1577.7554479055764;24857.378565536008;24877.751222487543;25041.74958250467;25290.494190116464;25339.61990570106;41482.792586038086;41631;41693.166136677704;41768.582314177685;41857.79071104625;244964;246202;246709;247971;248030;34020;34351.828240859635;34362.312753744285;36444.63555364519;41904.58095419007;51237.74381128071;51318.74340628273;51376.48623513866;51702;52072;37030.44454333241;37265;37394;37500;37593.62406376011;37313;37397.81301093477;37582.43626345552;37708.62291377161;37824.81087594544;43359.566404336816;43463.56536434595;43633.781831090644;43688.126237475706;43692;36038.639613603526;36256.63743362533;36742.26515469729;36797.16014199333;37010;26427.735722642527;26713.198604041132;27761.444771104867;27916.441671166056;27974.3006424841 09:39:32 INFO - PID 29828 | |2;jquery.html;592.931347656733;595.5801160182073;606.9089636554519;606.9348293744479;619.2692622705207;24641.753582464193;25524.361890952758;25535.87232063837;25551.105711300108;25553.488930221385;21079.47301317468;21260;25457.490850183032;25463.490730185385;25477.74522254777;6411.775587854414;6545.443637290812;6563.901541476882;6567.967160164192;6568.981807819796;6470.773522926698;6531.836704082412;6583.11127997719;6746.932530674704;6764.898526522106;6727.159105111861;6732.49506287028;6745.224299205581;6751.797446076625;6754.527183097185;6666.6333351665635;6668.833279168011;6715.1270334856645;6715.9328406715795;6739;6257.5932564383165;6259.655718935457;6272.2159730033745;6281.089242059921;6287;32332.515012274835;32728;33096.17259568506;33900.660993390244;34197.658023419695;2310.861348319106;2341.6955795746444;2345.917892873741;2346.741858395575;2348.0607756897207;20350.18599256028;21025.579488410298;21026.474338141517;21036;21083.68374474384;2359.8466099703464;2445.08309383981;2466.136852101768;2499.0878329409634;2524.0282491241005;146267.268663656;151073.2446337772;153911;168348;176828;16444.424445144603;16483.137474445066;16848.57878553046;16973.538836868585;17267.74098388525;26127.608085878346;26359.868200658875;26360;26375.472490550466;26416.207513774618;11317.547298108148;11380.968086913948;11470;11530.192886497865;11563.017143542726;10553.419561924014;10589.788204236027;10618.309809862489;10626.415547144827;10626.415547144827;10193.133583645473;10279.691609251584;10296.691099267035;10347.172226221885;10424.801147868093;2851.6435445569305;2944.8822047117874;2958.319586495118;2975.642922849272;2995.0864986179427;1055.5091882274778;1064.5794911010262;1076.1444651502075;1088.4013792414141;1106.1427393769732;22586;22770.31689049331;22796.658050129263;22915.885420573122;23006;1153.0717772193298;1158.5423757615695;1160.6692092753694;1167.4571324334224;1170.3796987596588;12230.266184028987;12671.429785659668;12760.425780839885;12791.936040319739;12872.227666339862;598455;599652;611729;616766;616977;128110.35944820216;129669.35165324113;134995;135247;136034;1196.3300551691082;1238.0900038471716;1269.149669721289;1287.1183239480986;1330.4877622115555;23615.173468928504;24140.87929560341;24154.396140095934;24406.51186976286;24432;63599.682001589696;64711;64752;64956;66820.66589667021;85253.57373213094;85856.14143858482;86720.56639716761;86845;87430;16150.353985840435;16287;16297.266623001757;16353.754693679843;16411.507654770376;25457.745422545537;25862.482750345265;26086.478270434105;27130.593041104796;27145.45709085847;21241.256556020464;21277;21547.569048619254;21629.78370216278;21692;18462.907685461487;18514.907425463327;18971.43085707431;18994.905025474785;19780.10989505447;21606;21837;21987.34037978863;22075;22116.778832211472;16099.03405795656;16192.757108643144;16342.346306148096;16416.835831641532;16450.177491125156;20378.388648340573;20402.489937751674;20593.897030514752;20706.171753129707;20742.170313187304 09:39:32 INFO - PID 29828 | |3;mootools.html;1501.2418728542089;1514.1293756090245;1553.3631211203394;1554.665746864424;1579.6366835627805;15833.524994250176;16348.75476867845;16484.917575412135;16503.09232992185;16525.338986440544;16892.324307027706;17141.31434742612;17143.571410714707;17144.914275428604;17160.39938602149;2948.484015297325;2964.392299578592;3010.698930106994;3026.6670666226696;3028.515437529996;2838.347180148567;2900.9419811603757;2967.8367689777056;2968.3914797466578;2969.124108388031;2942.54390569461;2946.484365236075;2980.3741214345014;2982.656994445634;2984.0749367696085;2855.7715382769434;2908.0403466855887;2923.108451922163;2924.7952643314975;2929.0773406376925;2818.5490321548455;2847.2597124747713;2858.1711303721895;2869.2253091665343;2873.1524200360946;15891.761623575656;16187.190640468047;16237.91881040599;16260.18699065042;16264.18679066042;8372.204640559137;8761.605727742202;8786.297096232285;8791.956040219822;8792.780180495538;5405.644954797039;5536.474034966672;5641.802536911229;5672.461116193955;5675.5459563234845;1969.3894892583346;1991.2930909527054;2026.5642886779412;2072.0779253232317;2075.284027010679;28050.438991220264;28292.85853570719;28321.85839070812;28325.575116373064;28326.858365708453;7326.743563975236;7385;7413.478597666173;7558.148253677884;7576.659050342638;18844.90577547131;18858.528536786416;18869.339573114874;18876.90561547211;18955.336563220222;8593.140685931481;8790.296776257885;8845.911540884637;8858.822823543493;8863;8047;8060.879086813702;8078.474899131537;8214.383921205814;8220.58897055145;5402.8109016185035;5573.247611572467;5867.765289388462;5885.2349194605285;5984.251968503937;1636.4108920788506;1646.588352911772;1662.168915542229;1663.1351697117432;1671.7963066592035;963.9036096390445;964.9276304277207;1030.6650338639972;1042.6142327338782;1067.4662668665667;10352.948235258775;10411.583536658449;10483.895161048444;10541.683749487527;10629;1086.5219303506433;1089.629525961177;1106.833974903771;1127.875933647298;1138.703936976392;6144.477719393813;6168.568200225941;6867.416269617039;6977.197622273504;7031.015657807911;23280.185193518144;23704.64443033356;24095;24120.51758964811;24136.396590085038;22798.31605051851;23457.178998734962;23598.64602030971;23677.289681309587;23715.88142059313;12559.93720031394;12705.364731763375;13022.869771302167;13063.281519516328;13077.01922355827;9752.219822414048;10129.59481620727;10276.09124753255;10336.224783141144;10368.896311036793;20056.298029568894;20235.392938211877;20737.585248294647;20806.271780487612;21433.03551340162;21344.7865521349;21350.466238344165;21350.466238344165;21375.144994200058;21534.461638459165;12504;13237.669058273621;13351.866481335062;13368.799468007794;13377.799333009818;13632.250226237653;14074;14552.781708274173;15344.232788360761;15526.068435893883;13230.404631791786;13254.271015093876;13285.468581257028;13425.597232083053;13709.862901370858;12805.935970320088;12850.164739291917;13047.217166970013;13054.673633159247;13142.737145257233;11478.081753459535;11633.302001879914;11637.825432618349;11644.2431241969;11652.30086194831;8254.587270636324;8799.516026618598;8830.42602230853;8852.513111778913;8893.333000024895;8842.159994800484;8911.796907417416;8959.372843900865;9041.954790226007;9042.909570904207 09:39:32 INFO - PID 29828 | |4;prototype.html;530.6975024236187;538.1739030588049;565.4882331490003;566.7279705741244;568.3038278109317;6241.469475094616;6265.428705637777;6291.559590828638;6295;6401.9039714404325;6041.24484439445;6118.204633397652;6137.41694539018;6183.845403864906;6229.844253893655;4830.565249127578;4890.633202509808;4912.901741965158;4922.8769280768;4955.702657840541;4774.832880849171;4920.557149856512;4938.111139994818;4943.1596628573225;4950.405951285851;4864.513548645143;4871.293662418947;4892;4900.215965445529;4913.631477639191;4871.196252618313;4890.46204917457;4893.486183950669;4918;4929.186684197103;4465.776711164462;4467.709598876063;4471.77641117946;4475.485319188302;4487.865364039084;6087.269527656666;6160.1991741073825;6163.722632481549;6173.41352571505;6190.84522886927;5740.799072032459;5756.366799652035;5809.3609702932645;5850.531957443394;5906;6633.800985970429;6698.933010669928;6705.698243579001;6772.424343930772;6798.830029249259;5098.719570423626;5101.132807422747;5103.923441148386;5105.693658380472;5106.08090543702;6955.339242771928;6978.476614253951;7011.82470438238;7012.509124361297;7020.262872398427;5128.7179205144075;5141.434442211354;5163.14808056674;5172.456892026358;5177.844664660066;5308.575313974873;5335.306410166653;5337.359516858002;5357.651752636066;5395.163749618815;5821.592488525763;5850.882982340329;5878.853028674232;5925.466707996301;5985.670788106696;6600.74252107388;6718.66406679664;6726.428253598499;6733.764318248838;6737.326267373223;1746.4760571828401;1801.3425099838464;1801.864860135495;1803.603207294393;1828.725691146312;1269.7206614544784;1270.6023374288209;1284.07546566472;1289.2200218867638;1309.4696647857634;6324.976007677499;6372;6401.199850018747;6429.235428765675;6430.903536446957;6650;6733.337660457161;6775.525713200029;6857.074294970115;6932.688029038705;6339.334369891095;6375.3943375380195;6383.4574061204385;6386.9361306386345;6460.481786780103;3541.6010675782923;3569.0905365629783;3590.2101537661674;3595.9460608090376;3605.1605040631644;6996.930030699729;7040.788776336718;7046.92953070473;7071.514981853868;7087.220405755363;6968.3728464438445;6969.337912898267;6972.607257427788;6973.860522789617;6993.930060699429;6965.965170174218;6997.655785311774;7050.964745176241;7095.716171353191;7143.7142514299885;6762.546052598715;6796.524243302922;6858.828529286808;6861.142357205349;6893.482988775761;6719.160104986877;6738.629375384401;6802.727890884309;6810.795676129724;6844.623545704835;6973.79078627642;7018.964905175441;7071.858562828817;7107.182673992557;7123.145222573325;5226.189940559219;5231.372235331784;5248.448912864094;5263.289455923401;5268.1834315681135;6621.569597976116;6701.798946031627;6706.228783689938;6808.7276508939085;6890.586564806128;6410.583312084699;6513.446357059703;6541.149650545399;6556.442702370161;6565.310642382672;6506.544541882023;6517.185351831021;6523.542522463102;6630.171228596426;6680.231773345933;6465.191851018622;6594.868102638016;6611.404973552403;6612.768553100618;6619.437347825488;6662.933370666231;6667.166604174478;6677.432418244503;6682.832929176615;6813.8977915330315;6590.80227593173;6614.66926653675;6627.271000190071;6629.701663425061;6645.767398141042 09:39:32 INFO - PID 29828 | |5;yui.html;953.3136141977774;965.0397854135132;967.4050458967735;981.0483830684234;981.1071924548662;19872.30446934356;20757.688634670474;20805;20812.791872081274;22851;20769.27307544236;21016.474588135305;21163.682544761803;21168.89415552924;21224.57550848982;985.9408435493875;1017.4048181813611;1017.7557386227326;1022.3252653248858;1023.1507848485776;1009.6970908727352;1071.919606029547;1073.8711354637455;1081.4808891731973;1082.7726177502695;1058.523664351045;1059.9983016049837;1060.6817954613623;1063.186662203415;1065.2649671726483;1035.77213013137;1037.1754455208052;1047.9895201048007;1051.9999999999961;1054.4095306628274;773.9961300193519;774.9418793590447;775.2441369664532;775.5501808950795;776.0067114093969;20355.491112722153;20499.28252511155;20733.792662073338;20895;20907.37277881666;18942.715859262124;19978.00109994509;21785.23751668684;22135.778642213692;22199.778002219933;17299.221535030953;17555.5611109722;17591.648167036714;17721.911390443092;17788.110594470225;3740.401535754266;3755.6056614055406;3767.8492860285555;3791.50710407648;3794.4118661607495;142171;142896;142987;144524;145571;16765.83234167643;17060.914695426443;17323.65352692939;17389;17407.3037078518;31636.525452118236;32986.505202421984;33042.17394565107;33143.3371332572;33224.335513289596;8969.865452018224;9413.670521531714;9503.334766566411;9535;9542.761430964281;4517.141743068806;4563.155816174019;4606.493285738566;4647.953520464752;4664.65015123867;6006.12911127884;6015.729292181863;6045.546584006217;6072.332043475214;6076.787312444043;1066.7226521104415;1123.859517560305;1124.1956659561286;1129.2941911305434;1133.2010932292715;735.9080114985627;750.313463181194;755.0599503618031;763.5723994563062;769.9576523291273;12807.807882881763;13728.176309421468;13735.45058197661;13781.310934453237;13912.44350226;755.1165136789969;756.9507981981153;757.1935888278965;766.8888011238339;767.8157242261929;6022.969885150546;6097.298810636834;6173.506119510428;6220.066989951453;6220.191375121296;126396.36801816116;127174;127223;127769.08346374812;127835;118517.40741296411;120638;121303;121606.39196803959;124121.37939310426;99672.50163749135;99777.50111249398;101333.49333253434;102756;104319;13833.723325533634;14409.495667652001;14631.341589628706;14844.257787110386;14874.553763387115;48639.27041094316;49328.753356234425;49418.258726118416;49980.750096249285;50106.74946625243;61150;61844.381556183864;61939;63602.36397636149;64733;19480.220791168194;20172.697409539163;20311.593768124258;20319.390418287476;20353;22554.436139096655;23076.307710768702;23165;23283.30150095432;23381;21169.470763231042;21316.253931112336;21345.14619415206;21363.14547418086;21614.783852161276;20234;20302.79697203009;20666.58666826625;20967.58064838725;21412.143514259256;20954.266600669514;20986.370408887757;21410.785892141503;21528.246511372028;22076.33770986873;14599.489017884323;14668.706625867637;15347.462838800588;15445.84554154444;15640.843591563938;14582.473791214661;14902.925485372503;15069.773953390488;15076.623084422978;15168.696626067196 09:39:32 INFO - PID 29828 | __end_tp_report 09:39:32 INFO - PID 29828 | __start_cc_report 09:39:32 INFO - PID 29828 | _x_x_mozilla_cycle_collect,261 09:39:32 INFO - PID 29828 | __end_cc_report 09:39:32 INFO - PID 29828 | __startTimestamp1502728772368__endTimestamp 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | ------- Summary: start ------- 09:39:32 INFO - PID 29828 | Number of tests: 6 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#0] dojo.html Cycles:165 Average:6371.58 Median:6665.40 stddev:814.93 (12.2%) stddev-sans-first:785.07 09:39:32 INFO - PID 29828 | Values: 3473.4 3523.2 3537.4 3614.9 3632.5 6287.0 6396.0 6402.5 6424.6 6439.6 6345.8 6384.6 6426.2 6466.8 6490.4 5461.3 5566.6 5609.6 5615.6 5677.5 5542.4 5546.1 5624.3 5638.6 5644.9 5612.0 5632.9 5636.9 5683.8 5704.4 5433.3 5611.6 5646.7 5672.5 5688.5 5480.3 5533.4 5548.5 5552.9 5572.3 6249.8 6251.7 6291.7 6307.0 6357.6 6881.0 6886.6 6962.4 6970.0 6984.9 6808.1 6887.5 6887.7 6987.1 7044.9 6495.8 6514.2 6573.9 6580.8 6584.2 6986.2 7091.4 7093.5 7125.5 7217.2 6779.5 6815.8 6877.0 6879.4 6886.6 6943.2 6979.4 7005.9 7021.2 7026.5 6664.8 6829.0 6841.0 6912.9 6925.2 6791.8 6858.5 6894.7 6946.4 6962.1 5112.1 5156.1 5157.9 5161.9 5175.5 4498.7 4594.1 4600.4 4603.0 4628.1 6303.5 6402.3 6403.2 6565.3 6645.4 6819.3 6895.4 6911.3 6965.3 7026.2 6617.4 6659.9 6665.4 6671.2 6700.7 5764.5 5845.5 5916.6 5917.0 5917.9 7000.8 7115.3 7127.4 7212.0 7301.5 6969.3 6990.4 6996.6 6999.9 7009.1 7160.7 7254.8 7259.1 7267.5 7271.6 6911.8 6956.9 6966.6 6971.0 6972.1 7004.9 7011.3 7013.5 7078.0 7090.4 6564.5 6633.3 6639.2 6653.8 6753.5 6698.4 6705.7 6727.9 6728.3 6731.3 6636.5 6690.7 6712.6 6723.4 6741.2 6800.2 6812.1 6841.2 6868.7 6891.8 6414.5 6517.8 6625.4 6626.1 6716.0 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#1] ext.html Cycles:180 Average:42821.01 Median:20804.35 stddev:64652.01 (310.8%) stddev-sans-first:64756.70 09:39:32 INFO - PID 29828 | Values: 883.3 925.3 959.3 978.5 985.5 41355.6 42108.8 42235.0 42283.4 42285.2 39056.6 39224.4 39319.6 39350.4 39409.4 7094.7 7198.4 7198.7 7199.1 7202.4 7093.5 7109.9 7174.9 7176.6 7179.9 7721.7 7907.2 7918.4 7919.8 7921.3 7821.4 7855.1 7858.9 7859.4 7868.0 7725.7 7727.5 7770.3 7775.8 7811.5 39983.0 40009.2 40109.4 40274.8 40314.0 3715.9 3779.1 3783.9 3784.5 3785.4 32204.0 32414.8 32467.4 32470.8 32566.3 5014.9 5163.4 5184.4 5189.8 5213.3 216441.0 216974.0 218150.0 219561.0 223407.9 51333.7 52129.5 52226.5 52240.0 52305.0 54793.5 54807.0 55097.2 55107.2 55176.2 16734.1 16798.7 16857.3 16865.3 17016.7 13801.0 13927.3 13930.0 13935.9 13966.1 15243.2 15303.8 15429.1 15439.6 15546.1 6035.3 6123.7 6137.3 6198.6 6204.4 1115.6 1120.4 1138.7 1139.9 1159.0 25850.4 26229.9 26362.6 26392.6 26428.9 1229.6 1229.9 1250.9 1254.7 1257.8 13373.9 13712.0 13779.4 14148.3 14215.4 275428.0 275818.0 277309.0 278333.0 278560.0 56388.4 56770.7 56891.7 57145.7 57216.0 1539.5 1551.8 1574.6 1574.8 1577.8 24857.4 24877.8 25041.7 25290.5 25339.6 41482.8 41631.0 41693.2 41768.6 41857.8 244964.0 246202.0 246709.0 247971.0 248030.0 34020.0 34351.8 34362.3 36444.6 41904.6 51237.7 51318.7 51376.5 51702.0 52072.0 37030.4 37265.0 37394.0 37500.0 37593.6 37313.0 37397.8 37582.4 37708.6 37824.8 43359.6 43463.6 43633.8 43688.1 43692.0 36038.6 36256.6 36742.3 36797.2 37010.0 26427.7 26713.2 27761.4 27916.4 27974.3 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#2] jquery.html Cycles:180 Average:41032.11 Median:22960.94 stddev:102123.90 (444.8%) stddev-sans-first:102365.25 09:39:32 INFO - PID 29828 | Values: 592.9 595.6 606.9 606.9 619.3 24641.8 25524.4 25535.9 25551.1 25553.5 21079.5 21260.0 25457.5 25463.5 25477.7 6411.8 6545.4 6563.9 6568.0 6569.0 6470.8 6531.8 6583.1 6746.9 6764.9 6727.2 6732.5 6745.2 6751.8 6754.5 6666.6 6668.8 6715.1 6715.9 6739.0 6257.6 6259.7 6272.2 6281.1 6287.0 32332.5 32728.0 33096.2 33900.7 34197.7 2310.9 2341.7 2345.9 2346.7 2348.1 20350.2 21025.6 21026.5 21036.0 21083.7 2359.8 2445.1 2466.1 2499.1 2524.0 146267.3 151073.2 153911.0 168348.0 176828.0 16444.4 16483.1 16848.6 16973.5 17267.7 26127.6 26359.9 26360.0 26375.5 26416.2 11317.5 11381.0 11470.0 11530.2 11563.0 10553.4 10589.8 10618.3 10626.4 10626.4 10193.1 10279.7 10296.7 10347.2 10424.8 2851.6 2944.9 2958.3 2975.6 2995.1 1055.5 1064.6 1076.1 1088.4 1106.1 22586.0 22770.3 22796.7 22915.9 23006.0 1153.1 1158.5 1160.7 1167.5 1170.4 12230.3 12671.4 12760.4 12791.9 12872.2 598455.0 599652.0 611729.0 616766.0 616977.0 128110.4 129669.4 134995.0 135247.0 136034.0 1196.3 1238.1 1269.1 1287.1 1330.5 23615.2 24140.9 24154.4 24406.5 24432.0 63599.7 64711.0 64752.0 64956.0 66820.7 85253.6 85856.1 86720.6 86845.0 87430.0 16150.4 16287.0 16297.3 16353.8 16411.5 25457.7 25862.5 26086.5 27130.6 27145.5 21241.3 21277.0 21547.6 21629.8 21692.0 18462.9 18514.9 18971.4 18994.9 19780.1 21606.0 21837.0 21987.3 22075.0 22116.8 16099.0 16192.8 16342.3 16416.8 16450.2 20378.4 20402.5 20593.9 20706.2 20742.2 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#3] mootools.html Cycles:180 Average:10448.25 Median:21483.75 stddev:7273.74 (33.9%) stddev-sans-first:7263.08 09:39:32 INFO - PID 29828 | Values: 1501.2 1514.1 1553.4 1554.7 1579.6 15833.5 16348.8 16484.9 16503.1 16525.3 16892.3 17141.3 17143.6 17144.9 17160.4 2948.5 2964.4 3010.7 3026.7 3028.5 2838.3 2900.9 2967.8 2968.4 2969.1 2942.5 2946.5 2980.4 2982.7 2984.1 2855.8 2908.0 2923.1 2924.8 2929.1 2818.5 2847.3 2858.2 2869.2 2873.2 15891.8 16187.2 16237.9 16260.2 16264.2 8372.2 8761.6 8786.3 8792.0 8792.8 5405.6 5536.5 5641.8 5672.5 5675.5 1969.4 1991.3 2026.6 2072.1 2075.3 28050.4 28292.9 28321.9 28325.6 28326.9 7326.7 7385.0 7413.5 7558.1 7576.7 18844.9 18858.5 18869.3 18876.9 18955.3 8593.1 8790.3 8845.9 8858.8 8863.0 8047.0 8060.9 8078.5 8214.4 8220.6 5402.8 5573.2 5867.8 5885.2 5984.3 1636.4 1646.6 1662.2 1663.1 1671.8 963.9 964.9 1030.7 1042.6 1067.5 10352.9 10411.6 10483.9 10541.7 10629.0 1086.5 1089.6 1106.8 1127.9 1138.7 6144.5 6168.6 6867.4 6977.2 7031.0 23280.2 23704.6 24095.0 24120.5 24136.4 22798.3 23457.2 23598.6 23677.3 23715.9 12559.9 12705.4 13022.9 13063.3 13077.0 9752.2 10129.6 10276.1 10336.2 10368.9 20056.3 20235.4 20737.6 20806.3 21433.0 21344.8 21350.5 21350.5 21375.1 21534.5 12504.0 13237.7 13351.9 13368.8 13377.8 13632.3 14074.0 14552.8 15344.2 15526.1 13230.4 13254.3 13285.5 13425.6 13709.9 12805.9 12850.2 13047.2 13054.7 13142.7 11478.1 11633.3 11637.8 11644.2 11652.3 8254.6 8799.5 8830.4 8852.5 8893.3 8842.2 8911.8 8959.4 9042.0 9042.9 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#4] prototype.html Cycles:180 Average:5664.51 Median:6355.67 stddev:1604.84 (25.3%) stddev-sans-first:1562.40 09:39:32 INFO - PID 29828 | Values: 530.7 538.2 565.5 566.7 568.3 6241.5 6265.4 6291.6 6295.0 6401.9 6041.2 6118.2 6137.4 6183.8 6229.8 4830.6 4890.6 4912.9 4922.9 4955.7 4774.8 4920.6 4938.1 4943.2 4950.4 4864.5 4871.3 4892.0 4900.2 4913.6 4871.2 4890.5 4893.5 4918.0 4929.2 4465.8 4467.7 4471.8 4475.5 4487.9 6087.3 6160.2 6163.7 6173.4 6190.8 5740.8 5756.4 5809.4 5850.5 5906.0 6633.8 6698.9 6705.7 6772.4 6798.8 5098.7 5101.1 5103.9 5105.7 5106.1 6955.3 6978.5 7011.8 7012.5 7020.3 5128.7 5141.4 5163.1 5172.5 5177.8 5308.6 5335.3 5337.4 5357.7 5395.2 5821.6 5850.9 5878.9 5925.5 5985.7 6600.7 6718.7 6726.4 6733.8 6737.3 1746.5 1801.3 1801.9 1803.6 1828.7 1269.7 1270.6 1284.1 1289.2 1309.5 6325.0 6372.0 6401.2 6429.2 6430.9 6650.0 6733.3 6775.5 6857.1 6932.7 6339.3 6375.4 6383.5 6386.9 6460.5 3541.6 3569.1 3590.2 3595.9 3605.2 6996.9 7040.8 7046.9 7071.5 7087.2 6968.4 6969.3 6972.6 6973.9 6993.9 6966.0 6997.7 7051.0 7095.7 7143.7 6762.5 6796.5 6858.8 6861.1 6893.5 6719.2 6738.6 6802.7 6810.8 6844.6 6973.8 7019.0 7071.9 7107.2 7123.1 5226.2 5231.4 5248.4 5263.3 5268.2 6621.6 6701.8 6706.2 6808.7 6890.6 6410.6 6513.4 6541.1 6556.4 6565.3 6506.5 6517.2 6523.5 6630.2 6680.2 6465.2 6594.9 6611.4 6612.8 6619.4 6662.9 6667.2 6677.4 6682.8 6813.9 6590.8 6614.7 6627.3 6629.7 6645.8 09:39:32 INFO - PID 29828 | 09:39:32 INFO - PID 29828 | [#5] yui.html Cycles:180 Average:26684.53 Median:20901.19 stddev:37136.49 (177.7%) stddev-sans-first:37190.41 09:39:32 INFO - PID 29828 | Values: 953.3 965.0 967.4 981.0 981.1 19872.3 20757.7 20805.0 20812.8 22851.0 20769.3 21016.5 21163.7 21168.9 21224.6 985.9 1017.4 1017.8 1022.3 1023.2 1009.7 1071.9 1073.9 1081.5 1082.8 1058.5 1060.0 1060.7 1063.2 1065.3 1035.8 1037.2 1048.0 1052.0 1054.4 774.0 774.9 775.2 775.6 776.0 20355.5 20499.3 20733.8 20895.0 20907.4 18942.7 19978.0 21785.2 22135.8 22199.8 17299.2 17555.6 17591.6 17721.9 17788.1 3740.4 3755.6 3767.8 3791.5 3794.4 142171.0 142896.0 142987.0 144524.0 145571.0 16765.8 17060.9 17323.7 17389.0 17407.3 31636.5 32986.5 33042.2 33143.3 33224.3 8969.9 9413.7 9503.3 9535.0 9542.8 4517.1 4563.2 4606.5 4648.0 4664.7 6006.1 6015.7 6045.5 6072.3 6076.8 1066.7 1123.9 1124.2 1129.3 1133.2 735.9 750.3 755.1 763.6 770.0 12807.8 13728.2 13735.5 13781.3 13912.4 755.1 757.0 757.2 766.9 767.8 6023.0 6097.3 6173.5 6220.1 6220.2 126396.4 127174.0 127223.0 127769.1 127835.0 118517.4 120638.0 121303.0 121606.4 124121.4 99672.5 99777.5 101333.5 102756.0 104319.0 13833.7 14409.5 14631.3 14844.3 14874.6 48639.3 49328.8 49418.3 49980.8 50106.7 61150.0 61844.4 61939.0 63602.4 64733.0 19480.2 20172.7 20311.6 20319.4 20353.0 22554.4 23076.3 23165.0 23283.3 23381.0 21169.5 21316.3 21345.1 21363.1 21614.8 20234.0 20302.8 20666.6 20967.6 21412.1 20954.3 20986.4 21410.8 21528.2 22076.3 14599.5 14668.7 15347.5 15445.8 15640.8 14582.5 14902.9 15069.8 15076.6 15168.7 09:39:32 INFO - PID 29828 | -------- Summary: end -------- 09:39:32 INFO - PID 29828 | 09:39:33 INFO - TEST-INFO | 29828: exit 0 09:39:33 INFO - TEST-OK | dromaeo_css | took 1108881ms 09:39:33 INFO - TEST-START | kraken 09:39:33 INFO - Initialising browser for kraken test... 09:39:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36238/getInfo.html -profile /tmp/tmpQG6KOy/profile 09:39:33 INFO - TEST-INFO | started process 30188 (/builds/slave/test/build/application/firefox/firefox http://localhost:36238/getInfo.html) 09:39:38 INFO - TEST-INFO | 30188: exit 0 09:39:38 INFO - Browser initialized. 09:39:38 INFO - Running cycle 1/1 for kraken test... 09:39:38 INFO - TEST-INFO | started process 30355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQG6KOy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:38 INFO - PID 30355 | 1502728778872 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 09:39:49 INFO - PID 30355 | RSS: Main: 139362304 09:39:49 INFO - PID 30355 | 09:39:52 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36238/tests/kraken/driver.html?testName=audio-beat-detection) 09:39:53 INFO - PID 30355 | RSS: Main: 146788352 09:39:53 INFO - PID 30355 | 09:39:55 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36238/tests/kraken/driver.html?testName=audio-dft) 09:39:56 INFO - PID 30355 | RSS: Main: 147345408 09:39:56 INFO - PID 30355 | 09:39:59 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36238/tests/kraken/driver.html?testName=audio-fft) 09:39:59 INFO - PID 30355 | RSS: Main: 147677184 09:39:59 INFO - PID 30355 | 09:40:01 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36238/tests/kraken/driver.html?testName=audio-oscillator) 09:40:02 INFO - PID 30355 | RSS: Main: 148029440 09:40:02 INFO - PID 30355 | 09:40:04 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:04 INFO - PID 30355 | RSS: Main: 147746816 09:40:04 INFO - PID 30355 | 09:40:07 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36238/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:08 INFO - PID 30355 | RSS: Main: 148267008 09:40:08 INFO - PID 30355 | 09:40:11 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36238/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:12 INFO - PID 30355 | RSS: Main: 150720512 09:40:12 INFO - PID 30355 | 09:40:15 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36238/tests/kraken/driver.html?testName=json-parse-financial) 09:40:15 INFO - PID 30355 | RSS: Main: 150835200 09:40:15 INFO - PID 30355 | 09:40:17 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:18 INFO - PID 30355 | RSS: Main: 151257088 09:40:18 INFO - PID 30355 | 09:40:19 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:20 INFO - PID 30355 | RSS: Main: 150843392 09:40:20 INFO - PID 30355 | 09:40:22 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:23 INFO - PID 30355 | RSS: Main: 151441408 09:40:23 INFO - PID 30355 | 09:40:25 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:26 INFO - PID 30355 | RSS: Main: 150945792 09:40:26 INFO - PID 30355 | 09:40:29 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:29 INFO - PID 30355 | RSS: Main: 151027712 09:40:29 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | Cycle 1(1): loaded http://localhost:36238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36238/tests/kraken/driver.html?testName=ai-astar) 09:40:31 INFO - PID 30355 | RSS: Main: 152535040 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | __start_tp_report 09:40:31 INFO - PID 30355 | _x_x_mozilla_page_load 09:40:31 INFO - PID 30355 | _x_x_mozilla_page_load_details 09:40:31 INFO - PID 30355 | |i|pagename|runs| 09:40:31 INFO - PID 30355 | |0;ai-astar;96;106;100;105;105;106;111;97;107;107 09:40:31 INFO - PID 30355 | |1;audio-beat-detection;140;111;133;159;111;139;135;113;167;112 09:40:31 INFO - PID 30355 | |2;audio-dft;162;161;163;162;160;161;161;160;163;160 09:40:31 INFO - PID 30355 | |3;audio-fft;76;74;76;186;75;73;75;75;161;76 09:40:31 INFO - PID 30355 | |4;audio-oscillator;78;78;125;77;78;77;127;76;77;124 09:40:31 INFO - PID 30355 | |5;imaging-gaussian-blur;113;113;114;114;113;117;116;117;115;113 09:40:31 INFO - PID 30355 | |6;imaging-darkroom;148;149;149;150;150;148;148;148;148;148 09:40:31 INFO - PID 30355 | |7;imaging-desaturate;93;94;93;94;94;93;94;93;93;94 09:40:31 INFO - PID 30355 | |8;json-parse-financial;46;46;46;48;47;49;46;47;47;48 09:40:31 INFO - PID 30355 | |9;json-stringify-tinderbox;52;53;52;52;52;52;52;52;52;53 09:40:31 INFO - PID 30355 | |10;stanford-crypto-aes;72;73;74;71;80;72;73;73;73;71 09:40:31 INFO - PID 30355 | |11;stanford-crypto-ccm;112;116;127;114;114;122;113;127;114;145 09:40:31 INFO - PID 30355 | |12;stanford-crypto-pbkdf2;163;162;169;157;157;156;153;170;152;156 09:40:31 INFO - PID 30355 | |13;stanford-crypto-sha256-iterative;60;58;63;62;59;58;58;58;61;58 09:40:31 INFO - PID 30355 | __end_tp_report 09:40:31 INFO - PID 30355 | __start_cc_report 09:40:31 INFO - PID 30355 | _x_x_mozilla_cycle_collect,714 09:40:31 INFO - PID 30355 | __end_cc_report 09:40:31 INFO - PID 30355 | __startTimestamp1502728831561__endTimestamp 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | ------- Summary: start ------- 09:40:31 INFO - PID 30355 | Number of tests: 14 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#0] ai-astar Cycles:10 Average:104.00 Median:107.00 stddev:4.78 (4.5%) stddev-sans-first:4.11 09:40:31 INFO - PID 30355 | Values: 96.0 106.0 100.0 105.0 105.0 106.0 111.0 97.0 107.0 107.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:137.00 stddev:20.33 (14.8%) stddev-sans-first:21.36 09:40:31 INFO - PID 30355 | Values: 140.0 111.0 133.0 159.0 111.0 139.0 135.0 113.0 167.0 112.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.20 09:40:31 INFO - PID 30355 | Values: 162.0 161.0 163.0 162.0 160.0 161.0 161.0 160.0 163.0 160.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:41.96 (55.9%) stddev-sans-first:43.95 09:40:31 INFO - PID 30355 | Values: 76.0 74.0 76.0 186.0 75.0 73.0 75.0 75.0 161.0 76.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:77.00 stddev:23.23 (30.2%) stddev-sans-first:24.10 09:40:31 INFO - PID 30355 | Values: 78.0 78.0 125.0 77.0 78.0 77.0 127.0 76.0 77.0 124.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.65 (1.4%) stddev-sans-first:1.66 09:40:31 INFO - PID 30355 | Values: 113.0 113.0 114.0 114.0 113.0 117.0 116.0 117.0 115.0 113.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 09:40:31 INFO - PID 30355 | Values: 148.0 149.0 149.0 150.0 150.0 148.0 148.0 148.0 148.0 148.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:40:31 INFO - PID 30355 | Values: 93.0 94.0 93.0 94.0 94.0 93.0 94.0 93.0 93.0 94.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:47.00 stddev:1.05 (2.2%) stddev-sans-first:1.05 09:40:31 INFO - PID 30355 | Values: 46.0 46.0 46.0 48.0 47.0 49.0 46.0 47.0 47.0 48.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#9] json-stringify-tinderbox Cycles:10 Average:52.20 Median:52.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:40:31 INFO - PID 30355 | Values: 52.0 53.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 53.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:2.57 (3.5%) stddev-sans-first:2.69 09:40:31 INFO - PID 30355 | Values: 72.0 73.0 74.0 71.0 80.0 72.0 73.0 73.0 73.0 71.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:119.00 stddev:10.34 (8.7%) stddev-sans-first:10.51 09:40:31 INFO - PID 30355 | Values: 112.0 116.0 127.0 114.0 114.0 122.0 113.0 127.0 114.0 145.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.50 Median:159.50 stddev:6.28 (3.9%) stddev-sans-first:6.53 09:40:31 INFO - PID 30355 | Values: 163.0 162.0 169.0 157.0 157.0 156.0 153.0 170.0 152.0 156.0 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:59.50 stddev:1.90 (3.2%) stddev-sans-first:2.01 09:40:31 INFO - PID 30355 | Values: 60.0 58.0 63.0 62.0 59.0 58.0 58.0 58.0 61.0 58.0 09:40:31 INFO - PID 30355 | -------- Summary: end -------- 09:40:31 INFO - PID 30355 | 09:40:31 INFO - PID 30355 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:40:32 INFO - TEST-INFO | 30355: exit 0 09:40:32 INFO - TEST-OK | kraken | took 59271ms 09:40:32 INFO - SUITE-END | took 1168s 09:40:32 INFO - Completed test suite (00:19:28) 09:40:32 INFO - javascript benchmark 09:40:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9203.186015603083, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3473.426884564044, 3523.154442933696, 3537.3809583322914, 3614.8915532534024, 3632.5096112024867, 6286.9685651571735, 6396.040593910916, 6402.487800975922, 6424.61452312861, 6439.581427207228, 6345.809625711225, 6384.648844313561, 6426.196725409324, 6466.773662921799, 6490.415862572368, 5461.262729531522, 5566.638168519054, 5609.635373700697, 5615.634983726065, 5677.460641239086, 5542.362628297757, 5546.140348246028, 5624.325080990287, 5638.577106716992, 5644.943550564483, 5612.017896868052, 5632.859178520529, 5636.859078523029, 5683.801066962657, 5704.429557044304, 5433.266509021271, 5611.607187496877, 5646.745896434671, 5672.546196304327, 5688.488036076773, 5480.287562616874, 5533.391326954032, 5548.528375088123, 5552.91670624941, 5572.3034620672415, 6249.78125765596, 6251.749930002795, 6291.653959032252, 6307.0, 6357.618542887395, 6881.002254673044, 6886.586804791728, 6962.373386395248, 6969.965150174267, 6984.930150698529, 6808.114945057111, 6887.483438742114, 6887.655617219119, 6987.091678081817, 7044.894326585106, 6495.805125846232, 6514.218293804774, 6573.93426065738, 6580.76967306142, 6584.209894812653, 6986.16166060076, 7091.3972312353, 7093.467989900778, 7125.465590080765, 7217.170025447036, 6779.49153813466, 6815.829604259933, 6876.965615171892, 6879.449644028566, 6886.621235831977, 6943.166819981635, 6979.3718565328345, 7005.92994070063, 7021.192562855234, 7026.473014523931, 6664.83337916556, 6829.043933849265, 6840.9657951710915, 6912.861742765116, 6925.168979722364, 6791.796246112624, 6858.485613579001, 6894.724211031603, 6946.444284457231, 6962.094927659473, 5112.130937740593, 5156.097682905476, 5157.871053223625, 5161.948380516222, 5175.508326708957, 4498.707584007029, 4594.1271158479785, 4600.42494688164, 4603.033362993742, 4628.097520983443, 6303.495720342362, 6402.295747467775, 6403.231612206565, 6565.310642382577, 6645.368689974444, 6819.283975182633, 6895.448364130857, 6911.308869113049, 6965.268646792014, 7026.227115017344, 6617.437517810944, 6659.933400666028, 6665.400113989765, 6671.166104236971, 6700.731970721214, 5764.510016648632, 5845.461485114491, 5916.585838991229, 5917.0, 5917.911231331534, 7000.789976300719, 7115.324044215791, 7127.394171495481, 7211.999999999895, 7301.525400848928, 6969.303069693092, 6990.440764738707, 6996.580205187705, 6999.895001574879, 7009.088818453569, 7160.749373771893, 7254.782356529313, 7259.092613423322, 7267.527610705287, 7271.563706177646, 6911.7926462206215, 6956.895646565406, 6966.616836073862, 6971.024056632177, 6972.1284839395075, 7004.859902801813, 7011.26381729911, 7013.473989450709, 7078.044463997295, 7090.361867431956, 6564.540482166202, 6633.336666333328, 6639.236487803964, 6653.833654158685, 6753.493487988322, 6698.363655452724, 6705.698243578953, 6727.93272067273, 6728.259891412039, 6731.259561448334, 6636.469082473294, 6690.665466726741, 6712.563683360566, 6723.394894459522, 6741.1910570731825, 6800.217974932748, 6812.14848143982, 6841.213260475109, 6868.7252509901045, 6891.793246202622, 6414.486841052798, 6517.771877984437, 6625.370589793962, 6626.105475760711, 6716.0], "value": 6309.776388790823, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.3286702106398, 925.2505470568844, 959.2517836087852, 978.5058545434555, 985.4579981010447, 41355.58644413555, 42108.78945605276, 42235.0, 42283.36574951378, 42285.15429691404, 39056.60943390565, 39224.41163382552, 39319.60680393195, 39350.40974385387, 39409.40885886707, 7094.680739366715, 7198.388137008361, 7198.7480438184675, 7199.136103667567, 7202.387797037232, 7093.538919970211, 7109.8933515997305, 7174.8565028699395, 7176.641167941608, 7179.856402871966, 7721.691132354699, 7907.2488113629115, 7918.366530677532, 7919.802004949865, 7921.287084162424, 7821.413393995473, 7855.13593504714, 7858.882116768253, 7859.410544209179, 7867.960660196691, 7725.729599464048, 7727.536347819148, 7770.261825126604, 7775.766726998199, 7811.531308121531, 39983.0, 40009.199816003806, 40109.398359024635, 40274.798626006974, 40314.0, 3715.851365945359, 3779.093017675738, 3783.886483405502, 3784.526934133233, 3785.413260944558, 32204.0, 32414.83792581022, 32467.350652987043, 32470.837645811855, 32566.348673026645, 5014.949850501484, 5163.432022477525, 5184.377874655028, 5189.792408303663, 5213.296205012351, 216441.0, 216974.0, 218150.0, 219561.0, 223407.8829605858, 51333.743331283105, 52129.47870521322, 52226.477735222164, 52240.0, 52305.0, 54793.452065478836, 54807.0, 55097.17354239689, 55107.17339239915, 55176.172357414674, 16734.079625620707, 16798.748018779726, 16857.325706971827, 16865.325386984383, 17016.744748828776, 13801.0, 13927.303634818218, 13930.0, 13935.860641393456, 13966.092204006707, 15243.161626110448, 15303.770443443358, 15429.074255544703, 15439.614009649624, 15546.067235965653, 6035.275766907999, 6123.693815309217, 6137.263528376534, 6198.566100372931, 6204.410580994799, 1115.5872327238974, 1120.4285814234636, 1138.7494751154732, 1139.9031082358092, 1158.9826152607718, 25850.35374115662, 26229.868850656007, 26362.604560931602, 26392.60411093835, 26428.8678556606, 1229.624964385871, 1229.9077569182168, 1250.8874201321926, 1254.667513109027, 1257.7610254051701, 13373.866261337262, 13712.0, 13779.381917435656, 14148.292585370691, 14215.36030878613, 275428.0, 275818.0, 277309.0, 278333.0, 278560.0, 56388.43611563914, 56770.71614641901, 56891.715541422025, 57145.714271429206, 57216.0, 1539.5073576455427, 1551.8137823461257, 1574.5748647865012, 1574.8109977623758, 1577.7554479055764, 24857.378565536008, 24877.751222487543, 25041.74958250467, 25290.494190116464, 25339.61990570106, 41482.792586038086, 41631.0, 41693.166136677704, 41768.582314177685, 41857.79071104625, 244964.0, 246202.0, 246709.0, 247971.0, 248030.0, 34020.0, 34351.828240859635, 34362.312753744285, 36444.63555364519, 41904.58095419007, 51237.74381128071, 51318.74340628273, 51376.48623513866, 51702.0, 52072.0, 37030.44454333241, 37265.0, 37394.0, 37500.0, 37593.62406376011, 37313.0, 37397.81301093477, 37582.43626345552, 37708.62291377161, 37824.81087594544, 43359.566404336816, 43463.56536434595, 43633.781831090644, 43688.126237475706, 43692.0, 36038.639613603526, 36256.63743362533, 36742.26515469729, 36797.16014199333, 37010.0, 26427.735722642527, 26713.198604041132, 27761.444771104867, 27916.441671166056, 27974.3006424841], "value": 18601.55265626018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.931347656733, 595.5801160182073, 606.9089636554519, 606.9348293744479, 619.2692622705207, 24641.753582464193, 25524.361890952758, 25535.87232063837, 25551.105711300108, 25553.488930221385, 21079.47301317468, 21260.0, 25457.490850183032, 25463.490730185385, 25477.74522254777, 6411.775587854414, 6545.443637290812, 6563.901541476882, 6567.967160164192, 6568.981807819796, 6470.773522926698, 6531.836704082412, 6583.11127997719, 6746.932530674704, 6764.898526522106, 6727.159105111861, 6732.49506287028, 6745.224299205581, 6751.797446076625, 6754.527183097185, 6666.6333351665635, 6668.833279168011, 6715.1270334856645, 6715.9328406715795, 6739.0, 6257.5932564383165, 6259.655718935457, 6272.2159730033745, 6281.089242059921, 6287.0, 32332.515012274835, 32728.0, 33096.17259568506, 33900.660993390244, 34197.658023419695, 2310.861348319106, 2341.6955795746444, 2345.917892873741, 2346.741858395575, 2348.0607756897207, 20350.18599256028, 21025.579488410298, 21026.474338141517, 21036.0, 21083.68374474384, 2359.8466099703464, 2445.08309383981, 2466.136852101768, 2499.0878329409634, 2524.0282491241005, 146267.268663656, 151073.2446337772, 153911.0, 168348.0, 176828.0, 16444.424445144603, 16483.137474445066, 16848.57878553046, 16973.538836868585, 17267.74098388525, 26127.608085878346, 26359.868200658875, 26360.0, 26375.472490550466, 26416.207513774618, 11317.547298108148, 11380.968086913948, 11470.0, 11530.192886497865, 11563.017143542726, 10553.419561924014, 10589.788204236027, 10618.309809862489, 10626.415547144827, 10626.415547144827, 10193.133583645473, 10279.691609251584, 10296.691099267035, 10347.172226221885, 10424.801147868093, 2851.6435445569305, 2944.8822047117874, 2958.319586495118, 2975.642922849272, 2995.0864986179427, 1055.5091882274778, 1064.5794911010262, 1076.1444651502075, 1088.4013792414141, 1106.1427393769732, 22586.0, 22770.31689049331, 22796.658050129263, 22915.885420573122, 23006.0, 1153.0717772193298, 1158.5423757615695, 1160.6692092753694, 1167.4571324334224, 1170.3796987596588, 12230.266184028987, 12671.429785659668, 12760.425780839885, 12791.936040319739, 12872.227666339862, 598455.0, 599652.0, 611729.0, 616766.0, 616977.0, 128110.35944820216, 129669.35165324113, 134995.0, 135247.0, 136034.0, 1196.3300551691082, 1238.0900038471716, 1269.149669721289, 1287.1183239480986, 1330.4877622115555, 23615.173468928504, 24140.87929560341, 24154.396140095934, 24406.51186976286, 24432.0, 63599.682001589696, 64711.0, 64752.0, 64956.0, 66820.66589667021, 85253.57373213094, 85856.14143858482, 86720.56639716761, 86845.0, 87430.0, 16150.353985840435, 16287.0, 16297.266623001757, 16353.754693679843, 16411.507654770376, 25457.745422545537, 25862.482750345265, 26086.478270434105, 27130.593041104796, 27145.45709085847, 21241.256556020464, 21277.0, 21547.569048619254, 21629.78370216278, 21692.0, 18462.907685461487, 18514.907425463327, 18971.43085707431, 18994.905025474785, 19780.10989505447, 21606.0, 21837.0, 21987.34037978863, 22075.0, 22116.778832211472, 16099.03405795656, 16192.757108643144, 16342.346306148096, 16416.835831641532, 16450.177491125156, 20378.388648340573, 20402.489937751674, 20593.897030514752, 20706.171753129707, 20742.170313187304], "value": 13315.143467624115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.2418728542089, 1514.1293756090245, 1553.3631211203394, 1554.665746864424, 1579.6366835627805, 15833.524994250176, 16348.75476867845, 16484.917575412135, 16503.09232992185, 16525.338986440544, 16892.324307027706, 17141.31434742612, 17143.571410714707, 17144.914275428604, 17160.39938602149, 2948.484015297325, 2964.392299578592, 3010.698930106994, 3026.6670666226696, 3028.515437529996, 2838.347180148567, 2900.9419811603757, 2967.8367689777056, 2968.3914797466578, 2969.124108388031, 2942.54390569461, 2946.484365236075, 2980.3741214345014, 2982.656994445634, 2984.0749367696085, 2855.7715382769434, 2908.0403466855887, 2923.108451922163, 2924.7952643314975, 2929.0773406376925, 2818.5490321548455, 2847.2597124747713, 2858.1711303721895, 2869.2253091665343, 2873.1524200360946, 15891.761623575656, 16187.190640468047, 16237.91881040599, 16260.18699065042, 16264.18679066042, 8372.204640559137, 8761.605727742202, 8786.297096232285, 8791.956040219822, 8792.780180495538, 5405.644954797039, 5536.474034966672, 5641.802536911229, 5672.461116193955, 5675.5459563234845, 1969.3894892583346, 1991.2930909527054, 2026.5642886779412, 2072.0779253232317, 2075.284027010679, 28050.438991220264, 28292.85853570719, 28321.85839070812, 28325.575116373064, 28326.858365708453, 7326.743563975236, 7385.0, 7413.478597666173, 7558.148253677884, 7576.659050342638, 18844.90577547131, 18858.528536786416, 18869.339573114874, 18876.90561547211, 18955.336563220222, 8593.140685931481, 8790.296776257885, 8845.911540884637, 8858.822823543493, 8863.0, 8047.0, 8060.879086813702, 8078.474899131537, 8214.383921205814, 8220.58897055145, 5402.8109016185035, 5573.247611572467, 5867.765289388462, 5885.2349194605285, 5984.251968503937, 1636.4108920788506, 1646.588352911772, 1662.168915542229, 1663.1351697117432, 1671.7963066592035, 963.9036096390445, 964.9276304277207, 1030.6650338639972, 1042.6142327338782, 1067.4662668665667, 10352.948235258775, 10411.583536658449, 10483.895161048444, 10541.683749487527, 10629.0, 1086.5219303506433, 1089.629525961177, 1106.833974903771, 1127.875933647298, 1138.703936976392, 6144.477719393813, 6168.568200225941, 6867.416269617039, 6977.197622273504, 7031.015657807911, 23280.185193518144, 23704.64443033356, 24095.0, 24120.51758964811, 24136.396590085038, 22798.31605051851, 23457.178998734962, 23598.64602030971, 23677.289681309587, 23715.88142059313, 12559.93720031394, 12705.364731763375, 13022.869771302167, 13063.281519516328, 13077.01922355827, 9752.219822414048, 10129.59481620727, 10276.09124753255, 10336.224783141144, 10368.896311036793, 20056.298029568894, 20235.392938211877, 20737.585248294647, 20806.271780487612, 21433.03551340162, 21344.7865521349, 21350.466238344165, 21350.466238344165, 21375.144994200058, 21534.461638459165, 12504.0, 13237.669058273621, 13351.866481335062, 13368.799468007794, 13377.799333009818, 13632.250226237653, 14074.0, 14552.781708274173, 15344.232788360761, 15526.068435893883, 13230.404631791786, 13254.271015093876, 13285.468581257028, 13425.597232083053, 13709.862901370858, 12805.935970320088, 12850.164739291917, 13047.217166970013, 13054.673633159247, 13142.737145257233, 11478.081753459535, 11633.302001879914, 11637.825432618349, 11644.2431241969, 11652.30086194831, 8254.587270636324, 8799.516026618598, 8830.42602230853, 8852.513111778913, 8893.333000024895, 8842.159994800484, 8911.796907417416, 8959.372843900865, 9041.954790226007, 9042.909570904207], "value": 7494.21562596156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.6975024236187, 538.1739030588049, 565.4882331490003, 566.7279705741244, 568.3038278109317, 6241.469475094616, 6265.428705637777, 6291.559590828638, 6295.0, 6401.9039714404325, 6041.24484439445, 6118.204633397652, 6137.41694539018, 6183.845403864906, 6229.844253893655, 4830.565249127578, 4890.633202509808, 4912.901741965158, 4922.8769280768, 4955.702657840541, 4774.832880849171, 4920.557149856512, 4938.111139994818, 4943.1596628573225, 4950.405951285851, 4864.513548645143, 4871.293662418947, 4892.0, 4900.215965445529, 4913.631477639191, 4871.196252618313, 4890.46204917457, 4893.486183950669, 4918.0, 4929.186684197103, 4465.776711164462, 4467.709598876063, 4471.77641117946, 4475.485319188302, 4487.865364039084, 6087.269527656666, 6160.1991741073825, 6163.722632481549, 6173.41352571505, 6190.84522886927, 5740.799072032459, 5756.366799652035, 5809.3609702932645, 5850.531957443394, 5906.0, 6633.800985970429, 6698.933010669928, 6705.698243579001, 6772.424343930772, 6798.830029249259, 5098.719570423626, 5101.132807422747, 5103.923441148386, 5105.693658380472, 5106.08090543702, 6955.339242771928, 6978.476614253951, 7011.82470438238, 7012.509124361297, 7020.262872398427, 5128.7179205144075, 5141.434442211354, 5163.14808056674, 5172.456892026358, 5177.844664660066, 5308.575313974873, 5335.306410166653, 5337.359516858002, 5357.651752636066, 5395.163749618815, 5821.592488525763, 5850.882982340329, 5878.853028674232, 5925.466707996301, 5985.670788106696, 6600.74252107388, 6718.66406679664, 6726.428253598499, 6733.764318248838, 6737.326267373223, 1746.4760571828401, 1801.3425099838464, 1801.864860135495, 1803.603207294393, 1828.725691146312, 1269.7206614544784, 1270.6023374288209, 1284.07546566472, 1289.2200218867638, 1309.4696647857634, 6324.976007677499, 6372.0, 6401.199850018747, 6429.235428765675, 6430.903536446957, 6650.0, 6733.337660457161, 6775.525713200029, 6857.074294970115, 6932.688029038705, 6339.334369891095, 6375.3943375380195, 6383.4574061204385, 6386.9361306386345, 6460.481786780103, 3541.6010675782923, 3569.0905365629783, 3590.2101537661674, 3595.9460608090376, 3605.1605040631644, 6996.930030699729, 7040.788776336718, 7046.92953070473, 7071.514981853868, 7087.220405755363, 6968.3728464438445, 6969.337912898267, 6972.607257427788, 6973.860522789617, 6993.930060699429, 6965.965170174218, 6997.655785311774, 7050.964745176241, 7095.716171353191, 7143.7142514299885, 6762.546052598715, 6796.524243302922, 6858.828529286808, 6861.142357205349, 6893.482988775761, 6719.160104986877, 6738.629375384401, 6802.727890884309, 6810.795676129724, 6844.623545704835, 6973.79078627642, 7018.964905175441, 7071.858562828817, 7107.182673992557, 7123.145222573325, 5226.189940559219, 5231.372235331784, 5248.448912864094, 5263.289455923401, 5268.1834315681135, 6621.569597976116, 6701.798946031627, 6706.228783689938, 6808.7276508939085, 6890.586564806128, 6410.583312084699, 6513.446357059703, 6541.149650545399, 6556.442702370161, 6565.310642382672, 6506.544541882023, 6517.185351831021, 6523.542522463102, 6630.171228596426, 6680.231773345933, 6465.191851018622, 6594.868102638016, 6611.404973552403, 6612.768553100618, 6619.437347825488, 6662.933370666231, 6667.166604174478, 6677.432418244503, 6682.832929176615, 6813.8977915330315, 6590.80227593173, 6614.66926653675, 6627.271000190071, 6629.701663425061, 6645.767398141042], "value": 5199.528709853821, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.3136141977774, 965.0397854135132, 967.4050458967735, 981.0483830684234, 981.1071924548662, 19872.30446934356, 20757.688634670474, 20805.0, 20812.791872081274, 22851.0, 20769.27307544236, 21016.474588135305, 21163.682544761803, 21168.89415552924, 21224.57550848982, 985.9408435493875, 1017.4048181813611, 1017.7557386227326, 1022.3252653248858, 1023.1507848485776, 1009.6970908727352, 1071.919606029547, 1073.8711354637455, 1081.4808891731973, 1082.7726177502695, 1058.523664351045, 1059.9983016049837, 1060.6817954613623, 1063.186662203415, 1065.2649671726483, 1035.77213013137, 1037.1754455208052, 1047.9895201048007, 1051.9999999999961, 1054.4095306628274, 773.9961300193519, 774.9418793590447, 775.2441369664532, 775.5501808950795, 776.0067114093969, 20355.491112722153, 20499.28252511155, 20733.792662073338, 20895.0, 20907.37277881666, 18942.715859262124, 19978.00109994509, 21785.23751668684, 22135.778642213692, 22199.778002219933, 17299.221535030953, 17555.5611109722, 17591.648167036714, 17721.911390443092, 17788.110594470225, 3740.401535754266, 3755.6056614055406, 3767.8492860285555, 3791.50710407648, 3794.4118661607495, 142171.0, 142896.0, 142987.0, 144524.0, 145571.0, 16765.83234167643, 17060.914695426443, 17323.65352692939, 17389.0, 17407.3037078518, 31636.525452118236, 32986.505202421984, 33042.17394565107, 33143.3371332572, 33224.335513289596, 8969.865452018224, 9413.670521531714, 9503.334766566411, 9535.0, 9542.761430964281, 4517.141743068806, 4563.155816174019, 4606.493285738566, 4647.953520464752, 4664.65015123867, 6006.12911127884, 6015.729292181863, 6045.546584006217, 6072.332043475214, 6076.787312444043, 1066.7226521104415, 1123.859517560305, 1124.1956659561286, 1129.2941911305434, 1133.2010932292715, 735.9080114985627, 750.313463181194, 755.0599503618031, 763.5723994563062, 769.9576523291273, 12807.807882881763, 13728.176309421468, 13735.45058197661, 13781.310934453237, 13912.44350226, 755.1165136789969, 756.9507981981153, 757.1935888278965, 766.8888011238339, 767.8157242261929, 6022.969885150546, 6097.298810636834, 6173.506119510428, 6220.066989951453, 6220.191375121296, 126396.36801816116, 127174.0, 127223.0, 127769.08346374812, 127835.0, 118517.40741296411, 120638.0, 121303.0, 121606.39196803959, 124121.37939310426, 99672.50163749135, 99777.50111249398, 101333.49333253434, 102756.0, 104319.0, 13833.723325533634, 14409.495667652001, 14631.341589628706, 14844.257787110386, 14874.553763387115, 48639.27041094316, 49328.753356234425, 49418.258726118416, 49980.750096249285, 50106.74946625243, 61150.0, 61844.381556183864, 61939.0, 63602.36397636149, 64733.0, 19480.220791168194, 20172.697409539163, 20311.593768124258, 20319.390418287476, 20353.0, 22554.436139096655, 23076.307710768702, 23165.0, 23283.30150095432, 23381.0, 21169.470763231042, 21316.253931112336, 21345.14619415206, 21363.14547418086, 21614.783852161276, 20234.0, 20302.79697203009, 20666.58666826625, 20967.58064838725, 21412.143514259256, 20954.266600669514, 20986.370408887757, 21410.785892141503, 21528.246511372028, 22076.33770986873, 14599.489017884323, 14668.706625867637, 15347.462838800588, 15445.84554154444, 15640.843591563938, 14582.473791214661, 14902.925485372503, 15069.773953390488, 15076.623084422978, 15168.696626067196], "value": 9977.07796560413, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 100.0, 105.0, 105.0, 106.0, 111.0, 97.0, 107.0, 107.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 133.0, 159.0, 111.0, 139.0, 135.0, 113.0, 167.0, 112.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 186.0, 75.0, 73.0, 75.0, 75.0, 161.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 125.0, 77.0, 78.0, 77.0, 127.0, 76.0, 77.0, 124.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 113.0, 117.0, 116.0, 117.0, 115.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 150.0, 150.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 46.0, 48.0, 47.0, 49.0, 46.0, 47.0, 47.0, 48.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 71.0, 80.0, 72.0, 73.0, 73.0, 73.0, 71.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 127.0, 114.0, 114.0, 122.0, 113.0, 127.0, 114.0, 145.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 169.0, 157.0, 157.0, 156.0, 153.0, 170.0, 152.0, 156.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 63.0, 62.0, 59.0, 58.0, 58.0, 58.0, 61.0, 58.0], "value": 59.5, "unit": "score"}]}]} 09:40:32 INFO - Return code: 0 09:40:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:40:32 INFO - # TBPL SUCCESS # 09:40:32 INFO - Running post-action listener: _package_coverage_data 09:40:32 INFO - Running post-action listener: _resource_record_post_action 09:40:32 INFO - [mozharness: 2017-08-14 16:40:32.861089Z] Finished run-tests step (success) 09:40:32 INFO - Running post-run listener: _resource_record_post_run 09:40:32 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 499712; Write bytes: 373534720; Read time: 132; Write time: 195328 09:40:32 INFO - TinderboxPrint: CPU usage
13.0% 09:40:32 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 132 09:40:32 INFO - TinderboxPrint: I/O write bytes / time
373,534,720 / 195,328 09:40:32 INFO - TinderboxPrint: CPU idle
8,212.1 (87.0%) 09:40:32 INFO - TinderboxPrint: CPU user
1,181.3 (12.5%) 09:40:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:40:32 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 98488320; Read time: 0; Write time: 51888 09:40:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:40:32 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 495616; Write bytes: 274382848; Read time: 124; Write time: 143376 09:40:33 INFO - Running post-run listener: _upload_blobber_files 09:40:33 INFO - Blob upload gear active. 09:40:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:40:33 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 09:40:33 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:40:33 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:40:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:40:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:34 INFO - (blobuploader) - INFO - Done attempting. 09:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:35 INFO - (blobuploader) - INFO - Done attempting. 09:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:42 INFO - (blobuploader) - INFO - Done attempting. 09:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:40:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:43 INFO - (blobuploader) - INFO - Done attempting. 09:40:43 INFO - (blobuploader) - INFO - Iteration through files over. 09:40:43 INFO - Return code: 0 09:40:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:40:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:40:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af86baf2f959a1088bf1dfea0b3e7d9c70157ed8d1c9c802983f7ec5c64e36179bf82fa743dafbabd9a51960535847032d6af4a846017fdbee7cadca4021a487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1395c99f55ad68fb41c23c68e3bd953c358181efa766b5db84ca4d7a3ecd57a1c7f07497e5b4efc4333bcc9490319fa71c389029592fb211b540f12558c6a66d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f13d63ae250c87968d0f22b727ba049d832f6a6fddabdd6627299901379b48b5d92a7354da6bd8c6406b2f2e3bd2e52d55a1bede6d759eb3a95396d2462ed52e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/158b400f6ae6e1a5677246571c1127fda47b0dc8b0d95bb72e9f51f18df9f7f3dc32770dff616312867a6274f06f27c096df483a4a06e7e88e64df6ad82d5378"} 09:40:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:40:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:40:43 INFO - Contents: 09:40:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af86baf2f959a1088bf1dfea0b3e7d9c70157ed8d1c9c802983f7ec5c64e36179bf82fa743dafbabd9a51960535847032d6af4a846017fdbee7cadca4021a487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1395c99f55ad68fb41c23c68e3bd953c358181efa766b5db84ca4d7a3ecd57a1c7f07497e5b4efc4333bcc9490319fa71c389029592fb211b540f12558c6a66d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f13d63ae250c87968d0f22b727ba049d832f6a6fddabdd6627299901379b48b5d92a7354da6bd8c6406b2f2e3bd2e52d55a1bede6d759eb3a95396d2462ed52e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/158b400f6ae6e1a5677246571c1127fda47b0dc8b0d95bb72e9f51f18df9f7f3dc32770dff616312867a6274f06f27c096df483a4a06e7e88e64df6ad82d5378"} 09:40:43 INFO - Running post-run listener: copy_logs_to_upload_dir 09:40:43 INFO - Copying logs to upload dir... 09:40:43 INFO - mkdir: /builds/slave/test/build/upload/logs 09:40:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.597235 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-14 09:40:42.554429) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 09:40:42.559854) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af86baf2f959a1088bf1dfea0b3e7d9c70157ed8d1c9c802983f7ec5c64e36179bf82fa743dafbabd9a51960535847032d6af4a846017fdbee7cadca4021a487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1395c99f55ad68fb41c23c68e3bd953c358181efa766b5db84ca4d7a3ecd57a1c7f07497e5b4efc4333bcc9490319fa71c389029592fb211b540f12558c6a66d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f13d63ae250c87968d0f22b727ba049d832f6a6fddabdd6627299901379b48b5d92a7354da6bd8c6406b2f2e3bd2e52d55a1bede6d759eb3a95396d2462ed52e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/158b400f6ae6e1a5677246571c1127fda47b0dc8b0d95bb72e9f51f18df9f7f3dc32770dff616312867a6274f06f27c096df483a4a06e7e88e64df6ad82d5378"} build_url:https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/M3MP4v6GSyyha90KOKlUGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/af86baf2f959a1088bf1dfea0b3e7d9c70157ed8d1c9c802983f7ec5c64e36179bf82fa743dafbabd9a51960535847032d6af4a846017fdbee7cadca4021a487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1395c99f55ad68fb41c23c68e3bd953c358181efa766b5db84ca4d7a3ecd57a1c7f07497e5b4efc4333bcc9490319fa71c389029592fb211b540f12558c6a66d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f13d63ae250c87968d0f22b727ba049d832f6a6fddabdd6627299901379b48b5d92a7354da6bd8c6406b2f2e3bd2e52d55a1bede6d759eb3a95396d2462ed52e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/158b400f6ae6e1a5677246571c1127fda47b0dc8b0d95bb72e9f51f18df9f7f3dc32770dff616312867a6274f06f27c096df483a4a06e7e88e64df6ad82d5378"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 09:40:42.588047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:40:42.588360) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502725056.73719-1252419281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 09:40:42.643702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 09:40:42.644018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 09:40:42.644317) ========= ========= Total master_lag: 0.36 =========