MongoDB 6.0

[ashie]

No description provided.

[ashie]

A test fails on MongoDB 6.0:

2022-12-30T05:25:22.7925265Z Requested labels: ubuntu-latest
2022-12-30T05:25:22.7925299Z Job defined at: fluent/fluent-plugin-mongo/.github/workflows/linux.yml@refs/pull/177/merge
2022-12-30T05:25:22.7925323Z Waiting for a runner to pick up this job...
2022-12-30T05:25:23.5891929Z Job is waiting for a hosted runner to come online.
2022-12-30T05:25:27.6835756Z Job is about to start running on the hosted runner: GitHub Actions 8 (hosted)
2022-12-30T05:25:30.4678032Z Current runner version: '2.299.1'
2022-12-30T05:25:30.4715205Z ##[group]Operating System
2022-12-30T05:25:30.4716265Z Ubuntu
2022-12-30T05:25:30.4716617Z 22.04.1
2022-12-30T05:25:30.4716860Z LTS
2022-12-30T05:25:30.4717204Z ##[endgroup]
2022-12-30T05:25:30.4717617Z ##[group]Runner Image
2022-12-30T05:25:30.4717955Z Image: ubuntu-22.04
2022-12-30T05:25:30.4718416Z Version: 20221212.1
2022-12-30T05:25:30.4719108Z Included Software: https://github.com/actions/runner-images/blob/ubuntu22/20221212.1/images/linux/Ubuntu2204-Readme.md
2022-12-30T05:25:30.4719738Z Image Release: https://github.com/actions/runner-images/releases/tag/ubuntu22%2F20221212.1
2022-12-30T05:25:30.4720255Z ##[endgroup]
2022-12-30T05:25:30.4720627Z ##[group]Runner Image Provisioner
2022-12-30T05:25:30.4720982Z 2.0.91.1
2022-12-30T05:25:30.4721275Z ##[endgroup]
2022-12-30T05:25:30.4722370Z ##[group]GITHUB_TOKEN Permissions
2022-12-30T05:25:30.4723108Z Actions: write
2022-12-30T05:25:30.4848906Z Checks: write
2022-12-30T05:25:30.4849451Z Contents: write
2022-12-30T05:25:30.4849768Z Deployments: write
2022-12-30T05:25:30.4850060Z Discussions: write
2022-12-30T05:25:30.4850317Z Issues: write
2022-12-30T05:25:30.4850679Z Metadata: read
2022-12-30T05:25:30.4850923Z Packages: write
2022-12-30T05:25:30.4851159Z Pages: write
2022-12-30T05:25:30.4851411Z PullRequests: write
2022-12-30T05:25:30.4851694Z RepositoryProjects: write
2022-12-30T05:25:30.4852035Z SecurityEvents: write
2022-12-30T05:25:30.4852438Z Statuses: write
2022-12-30T05:25:30.4852722Z ##[endgroup]
2022-12-30T05:25:30.4857951Z Secret source: Actions
2022-12-30T05:25:30.4858414Z Prepare workflow directory
2022-12-30T05:25:30.5822193Z Prepare all required actions
2022-12-30T05:25:30.6039148Z Getting action download info
2022-12-30T05:25:31.0858669Z Download action repository 'actions/checkout@v3' (SHA:755da8c3cf115ac066823e79a1e1788f8940201b)
2022-12-30T05:25:31.8060088Z Download action repository 'ruby/setup-ruby@v1' (SHA:03b78bdda287ae04217ee12e4b64996630a03542)
2022-12-30T05:25:32.2935036Z Download action repository 'supercharge/mongodb-github-action@1.8.0' (SHA:538a4d2a1041920c47630172445cb688592d6e51)
2022-12-30T05:25:32.9315307Z ##[group]Build container for action use: '/home/runner/work/_actions/supercharge/mongodb-github-action/1.8.0/Dockerfile'.
2022-12-30T05:25:32.9399768Z ##[command]/usr/bin/docker build -t 290506:47e5fbe7aed248c1a44640d95da64acd -f "/home/runner/work/_actions/supercharge/mongodb-github-action/1.8.0/Dockerfile" "/home/runner/work/_actions/supercharge/mongodb-github-action/1.8.0"
2022-12-30T05:25:33.1461490Z Sending build context to Docker daemon  39.94kB
2022-12-30T05:25:33.1476543Z 
2022-12-30T05:25:33.1972599Z Step 1/4 : FROM docker:stable
2022-12-30T05:25:34.2022262Z stable: Pulling from library/docker
2022-12-30T05:25:34.4468771Z 188c0c94c7c5: Pulling fs layer
2022-12-30T05:25:34.4470263Z 0c7c675703d6: Pulling fs layer
2022-12-30T05:25:34.4470982Z cc8c12a437cb: Pulling fs layer
2022-12-30T05:25:34.4471315Z f092543453df: Pulling fs layer
2022-12-30T05:25:34.4471572Z 65b6bc45957d: Pulling fs layer
2022-12-30T05:25:34.4471869Z 4de832df471b: Pulling fs layer
2022-12-30T05:25:34.4472183Z 79aa7fa92271: Pulling fs layer
2022-12-30T05:25:34.4472429Z f092543453df: Waiting
2022-12-30T05:25:34.4472638Z 65b6bc45957d: Waiting
2022-12-30T05:25:34.4472866Z 4de832df471b: Waiting
2022-12-30T05:25:34.4473102Z 79aa7fa92271: Waiting
2022-12-30T05:25:34.7106774Z 0c7c675703d6: Download complete
2022-12-30T05:25:34.7201132Z cc8c12a437cb: Download complete
2022-12-30T05:25:34.8293167Z 188c0c94c7c5: Verifying Checksum
2022-12-30T05:25:34.8302140Z 188c0c94c7c5: Download complete
2022-12-30T05:25:35.0108330Z 65b6bc45957d: Verifying Checksum
2022-12-30T05:25:35.0109420Z 65b6bc45957d: Download complete
2022-12-30T05:25:35.1239525Z 188c0c94c7c5: Pull complete
2022-12-30T05:25:35.1248647Z 4de832df471b: Verifying Checksum
2022-12-30T05:25:35.1251165Z 4de832df471b: Download complete
2022-12-30T05:25:35.2800236Z 79aa7fa92271: Verifying Checksum
2022-12-30T05:25:35.2833766Z 79aa7fa92271: Download complete
2022-12-30T05:25:35.6252534Z f092543453df: Verifying Checksum
2022-12-30T05:25:35.6253096Z f092543453df: Download complete
2022-12-30T05:25:35.6644425Z 0c7c675703d6: Pull complete
2022-12-30T05:25:35.7465263Z cc8c12a437cb: Pull complete
2022-12-30T05:25:38.4595395Z f092543453df: Pull complete
2022-12-30T05:25:38.5310554Z 65b6bc45957d: Pull complete
2022-12-30T05:25:38.6111754Z 4de832df471b: Pull complete
2022-12-30T05:25:38.6761579Z 79aa7fa92271: Pull complete
2022-12-30T05:25:38.6863823Z Digest: sha256:fd4d028713fd05a1fb896412805daed82c4a0cc84331d8dad00cb596d7ce3e3a
2022-12-30T05:25:38.6910350Z Status: Downloaded newer image for docker:stable
2022-12-30T05:25:38.6936204Z  ---> b0757c55a1fd
2022-12-30T05:25:38.6938580Z Step 2/4 : COPY start-mongodb.sh /start-mongodb.sh
2022-12-30T05:25:39.0115373Z  ---> 0b24abfb6f6e
2022-12-30T05:25:39.0115959Z Step 3/4 : RUN chmod +x /start-mongodb.sh
2022-12-30T05:25:39.0319430Z  ---> Running in 351f26c1fce3
2022-12-30T05:25:40.0159099Z Removing intermediate container 351f26c1fce3
2022-12-30T05:25:40.0159870Z  ---> 7d8287787780
2022-12-30T05:25:40.0160549Z Step 4/4 : ENTRYPOINT ["/start-mongodb.sh"]
2022-12-30T05:25:40.0434527Z  ---> Running in fad4929bd709
2022-12-30T05:25:41.0125272Z Removing intermediate container fad4929bd709
2022-12-30T05:25:41.0125596Z  ---> 4042ff390364
2022-12-30T05:25:41.0131059Z Successfully built 4042ff390364
2022-12-30T05:25:41.0185772Z Successfully tagged 290506:47e5fbe7aed248c1a44640d95da64acd
2022-12-30T05:25:41.0206293Z ##[endgroup]
2022-12-30T05:25:41.0693444Z ##[group]Run actions/checkout@v3
2022-12-30T05:25:41.0693921Z with:
2022-12-30T05:25:41.0694273Z   repository: fluent/fluent-plugin-mongo
2022-12-30T05:25:41.0694775Z   token: ***
2022-12-30T05:25:41.0695067Z   ssh-strict: true
2022-12-30T05:25:41.0695371Z   persist-credentials: true
2022-12-30T05:25:41.0695672Z   clean: true
2022-12-30T05:25:41.0695956Z   fetch-depth: 1
2022-12-30T05:25:41.0696222Z   lfs: false
2022-12-30T05:25:41.0696440Z   submodules: false
2022-12-30T05:25:41.0696749Z   set-safe-directory: true
2022-12-30T05:25:41.0697106Z ##[endgroup]
2022-12-30T05:25:41.4362284Z Syncing repository: fluent/fluent-plugin-mongo
2022-12-30T05:25:41.4364463Z ##[group]Getting Git version info
2022-12-30T05:25:41.4365432Z Working directory is '/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo'
2022-12-30T05:25:41.4366170Z [command]/usr/bin/git version
2022-12-30T05:25:41.4499809Z git version 2.38.2
2022-12-30T05:25:41.4541182Z ##[endgroup]
2022-12-30T05:25:41.4565738Z Temporarily overriding HOME='/home/runner/work/_temp/49d066f6-b772-4b02-9f11-a4fa1c509270' before making global git config changes
2022-12-30T05:25:41.4566356Z Adding repository directory to the temporary git global config as a safe directory
2022-12-30T05:25:41.4570411Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo
2022-12-30T05:25:41.4633053Z Deleting the contents of '/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo'
2022-12-30T05:25:41.4641269Z ##[group]Initializing the repository
2022-12-30T05:25:41.4646002Z [command]/usr/bin/git init /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo
2022-12-30T05:25:41.4749683Z hint: Using 'master' as the name for the initial branch. This default branch name
2022-12-30T05:25:41.4751069Z hint: is subject to change. To configure the initial branch name to use in all
2022-12-30T05:25:41.4755273Z hint: of your new repositories, which will suppress this warning, call:
2022-12-30T05:25:41.4756139Z hint: 
2022-12-30T05:25:41.4758537Z hint: 	git config --global init.defaultBranch <name>
2022-12-30T05:25:41.4759458Z hint: 
2022-12-30T05:25:41.4807927Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
2022-12-30T05:25:41.4808459Z hint: 'development'. The just-created branch can be renamed via this command:
2022-12-30T05:25:41.4808869Z hint: 
2022-12-30T05:25:41.4809348Z hint: 	git branch -m <name>
2022-12-30T05:25:41.4810027Z Initialized empty Git repository in /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/.git/
2022-12-30T05:25:41.4810993Z [command]/usr/bin/git remote add origin https://github.com/fluent/fluent-plugin-mongo
2022-12-30T05:25:41.4850526Z ##[endgroup]
2022-12-30T05:25:41.4851217Z ##[group]Disabling automatic garbage collection
2022-12-30T05:25:41.4855526Z [command]/usr/bin/git config --local gc.auto 0
2022-12-30T05:25:41.4892430Z ##[endgroup]
2022-12-30T05:25:41.4893538Z ##[group]Setting up auth
2022-12-30T05:25:41.4903438Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand
2022-12-30T05:25:41.4944980Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"
2022-12-30T05:25:41.5397078Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader
2022-12-30T05:25:41.5471264Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"
2022-12-30T05:25:41.5767750Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic ***
2022-12-30T05:25:41.5839454Z ##[endgroup]
2022-12-30T05:25:41.5840699Z ##[group]Fetching the repository
2022-12-30T05:25:41.5851145Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --progress --no-recurse-submodules --depth=1 origin +9fb381df201b4f242480004304f88b648260fc9f:refs/remotes/pull/177/merge
2022-12-30T05:25:42.0325931Z remote: Enumerating objects: 30, done.        
2022-12-30T05:25:42.0336845Z remote: Counting objects:   3% (1/30)        
2022-12-30T05:25:42.0338009Z remote: Counting objects:   6% (2/30)        
2022-12-30T05:25:42.0338739Z remote: Counting objects:  10% (3/30)        
2022-12-30T05:25:42.0339573Z remote: Counting objects:  13% (4/30)        
2022-12-30T05:25:42.0340294Z remote: Counting objects:  16% (5/30)        
2022-12-30T05:25:42.0341190Z remote: Counting objects:  20% (6/30)        
2022-12-30T05:25:42.0341932Z remote: Counting objects:  23% (7/30)        
2022-12-30T05:25:42.0344240Z remote: Counting objects:  26% (8/30)        
2022-12-30T05:25:42.0345120Z remote: Counting objects:  30% (9/30)        
2022-12-30T05:25:42.0346391Z remote: Counting objects:  33% (10/30)        
2022-12-30T05:25:42.0347256Z remote: Counting objects:  36% (11/30)        
2022-12-30T05:25:42.0347746Z remote: Counting objects:  40% (12/30)        
2022-12-30T05:25:42.0348272Z remote: Counting objects:  43% (13/30)        
2022-12-30T05:25:42.0349211Z remote: Counting objects:  46% (14/30)        
2022-12-30T05:25:42.0349973Z remote: Counting objects:  50% (15/30)        
2022-12-30T05:25:42.0351456Z remote: Counting objects:  53% (16/30)        
2022-12-30T05:25:42.0352139Z remote: Counting objects:  56% (17/30)        
2022-12-30T05:25:42.0353387Z remote: Counting objects:  60% (18/30)        
2022-12-30T05:25:42.0353991Z remote: Counting objects:  63% (19/30)        
2022-12-30T05:25:42.0355128Z remote: Counting objects:  66% (20/30)        
2022-12-30T05:25:42.0356097Z remote: Counting objects:  70% (21/30)        
2022-12-30T05:25:42.0357075Z remote: Counting objects:  73% (22/30)        
2022-12-30T05:25:42.0357658Z remote: Counting objects:  76% (23/30)        
2022-12-30T05:25:42.0358532Z remote: Counting objects:  80% (24/30)        
2022-12-30T05:25:42.0359396Z remote: Counting objects:  83% (25/30)        
2022-12-30T05:25:42.0360815Z remote: Counting objects:  86% (26/30)        
2022-12-30T05:25:42.0361145Z remote: Counting objects:  90% (27/30)        
2022-12-30T05:25:42.0361520Z remote: Counting objects:  93% (28/30)        
2022-12-30T05:25:42.0361993Z remote: Counting objects:  96% (29/30)        
2022-12-30T05:25:42.0362333Z remote: Counting objects: 100% (30/30)        
2022-12-30T05:25:42.0362748Z remote: Counting objects: 100% (30/30), done.        
2022-12-30T05:25:42.0363151Z remote: Compressing objects:   4% (1/25)        
2022-12-30T05:25:42.0363840Z remote: Compressing objects:   8% (2/25)        
2022-12-30T05:25:42.0364204Z remote: Compressing objects:  12% (3/25)        
2022-12-30T05:25:42.0364589Z remote: Compressing objects:  16% (4/25)        
2022-12-30T05:25:42.0364982Z remote: Compressing objects:  20% (5/25)        
2022-12-30T05:25:42.0365322Z remote: Compressing objects:  24% (6/25)        
2022-12-30T05:25:42.0365752Z remote: Compressing objects:  28% (7/25)        
2022-12-30T05:25:42.0366166Z remote: Compressing objects:  32% (8/25)        
2022-12-30T05:25:42.0366498Z remote: Compressing objects:  36% (9/25)        
2022-12-30T05:25:42.0366890Z remote: Compressing objects:  40% (10/25)        
2022-12-30T05:25:42.0367278Z remote: Compressing objects:  44% (11/25)        
2022-12-30T05:25:42.0499448Z remote: Compressing objects:  48% (12/25)        
2022-12-30T05:25:42.0499791Z remote: Compressing objects:  52% (13/25)        
2022-12-30T05:25:42.0500089Z remote: Compressing objects:  56% (14/25)        
2022-12-30T05:25:42.0500458Z remote: Compressing objects:  60% (15/25)        
2022-12-30T05:25:42.0500766Z remote: Compressing objects:  64% (16/25)        
2022-12-30T05:25:42.0501057Z remote: Compressing objects:  68% (17/25)        
2022-12-30T05:25:42.0501364Z remote: Compressing objects:  72% (18/25)        
2022-12-30T05:25:42.0501667Z remote: Compressing objects:  76% (19/25)        
2022-12-30T05:25:42.0501958Z remote: Compressing objects:  80% (20/25)        
2022-12-30T05:25:42.0502599Z remote: Compressing objects:  84% (21/25)        
2022-12-30T05:25:42.0502932Z remote: Compressing objects:  88% (22/25)        
2022-12-30T05:25:42.0503228Z remote: Compressing objects:  92% (23/25)        
2022-12-30T05:25:42.0504043Z remote: Compressing objects:  96% (24/25)        
2022-12-30T05:25:42.0504362Z remote: Compressing objects: 100% (25/25)        
2022-12-30T05:25:42.0504685Z remote: Compressing objects: 100% (25/25), done.        
2022-12-30T05:25:42.0537087Z remote: Total 30 (delta 1), reused 13 (delta 0), pack-reused 0        
2022-12-30T05:25:42.0624941Z From https://github.com/fluent/fluent-plugin-mongo
2022-12-30T05:25:42.0625706Z  * [new ref]         9fb381df201b4f242480004304f88b648260fc9f -> pull/177/merge
2022-12-30T05:25:42.0666015Z ##[endgroup]
2022-12-30T05:25:42.0666885Z ##[group]Determining the checkout info
2022-12-30T05:25:42.0668927Z ##[endgroup]
2022-12-30T05:25:42.0669738Z ##[group]Checking out the ref
2022-12-30T05:25:42.0675923Z [command]/usr/bin/git checkout --progress --force refs/remotes/pull/177/merge
2022-12-30T05:25:42.0755649Z Note: switching to 'refs/remotes/pull/177/merge'.
2022-12-30T05:25:42.0757744Z 
2022-12-30T05:25:42.0758296Z You are in 'detached HEAD' state. You can look around, make experimental
2022-12-30T05:25:42.0758719Z changes and commit them, and you can discard any commits you make in this
2022-12-30T05:25:42.0759374Z state without impacting any branches by switching back to a branch.
2022-12-30T05:25:42.0759717Z 
2022-12-30T05:25:42.0760033Z If you want to create a new branch to retain commits you create, you may
2022-12-30T05:25:42.0760571Z do so (now or later) by using -c with the switch command. Example:
2022-12-30T05:25:42.0760922Z 
2022-12-30T05:25:42.0761428Z   git switch -c <new-branch-name>
2022-12-30T05:25:42.0762850Z 
2022-12-30T05:25:42.0767990Z Or undo this operation with:
2022-12-30T05:25:42.0768567Z 
2022-12-30T05:25:42.0768818Z   git switch -
2022-12-30T05:25:42.0768975Z 
2022-12-30T05:25:42.0769208Z Turn off this advice by setting config variable advice.detachedHead to false
2022-12-30T05:25:42.0769461Z 
2022-12-30T05:25:42.0770055Z HEAD is now at 9fb381d Merge 1ffd5b0e032be65eb052d11e9fc67570404b4522 into 13e4575dc1816d1d3295f5929be1b0874e82a96f
2022-12-30T05:25:42.0776320Z ##[endgroup]
2022-12-30T05:25:42.0884827Z [command]/usr/bin/git log -1 --format='%H'
2022-12-30T05:25:42.0943821Z '9fb381df201b4f242480004304f88b648260fc9f'
2022-12-30T05:25:42.1404100Z ##[group]Run ruby/setup-ruby@v1
2022-12-30T05:25:42.1404399Z with:
2022-12-30T05:25:42.1404787Z   ruby-version: 3.0
2022-12-30T05:25:42.1405033Z   bundler-cache: false
2022-12-30T05:25:42.1405274Z ##[endgroup]
2022-12-30T05:25:42.3439833Z ##[group]Modifying PATH
2022-12-30T05:25:42.3441455Z Entries added to PATH to use selected Ruby:
2022-12-30T05:25:42.3445406Z   /opt/hostedtoolcache/Ruby/3.0.5/x64/bin
2022-12-30T05:25:42.3447613Z ##[endgroup]
2022-12-30T05:25:42.3562394Z ##[group]Downloading Ruby
2022-12-30T05:25:42.3567932Z https://github.com/ruby/ruby-builder/releases/download/toolcache/ruby-3.0.5-ubuntu-22.04.tar.gz
2022-12-30T05:25:42.8850913Z Took   0.52 seconds
2022-12-30T05:25:42.8851440Z ##[endgroup]
2022-12-30T05:25:42.8851866Z ##[group]Extracting  Ruby
2022-12-30T05:25:42.8884772Z [command]/usr/bin/tar -xz -C /opt/hostedtoolcache/Ruby/3.0.5 -f /home/runner/work/_temp/00bc0aed-0160-457c-a3fe-82610deda671
2022-12-30T05:25:43.5066438Z Took   0.62 seconds
2022-12-30T05:25:43.5067158Z ##[endgroup]
2022-12-30T05:25:43.5067716Z ##[group]Print Ruby version
2022-12-30T05:25:43.5096598Z [command]/opt/hostedtoolcache/Ruby/3.0.5/x64/bin/ruby --version
2022-12-30T05:25:43.5301892Z ruby 3.0.5p211 (2022-11-24 revision ba5cf0f7c5) [x86_64-linux]
2022-12-30T05:25:43.5318859Z Took   0.03 seconds
2022-12-30T05:25:43.5319819Z ##[endgroup]
2022-12-30T05:25:43.5321800Z ##[group]Installing Bundler
2022-12-30T05:25:43.5327838Z Using Bundler 2 shipped with ruby-3.0.5
2022-12-30T05:25:43.5328438Z Took   0.00 seconds
2022-12-30T05:25:43.5329311Z ##[endgroup]
2022-12-30T05:25:43.5508310Z ##[group]Run supercharge/mongodb-github-action@1.8.0
2022-12-30T05:25:43.5508657Z with:
2022-12-30T05:25:43.5508892Z   mongodb-version: 6.0
2022-12-30T05:25:43.5509138Z   mongodb-port: 27017
2022-12-30T05:25:43.5509386Z ##[endgroup]
2022-12-30T05:25:43.5824834Z ##[command]/usr/bin/docker run --name e5fbe7aed248c1a44640d95da64acd_a5c165 --label 290506 --workdir /github/workspace --rm -e "INPUT_MONGODB-VERSION" -e "INPUT_MONGODB-REPLICA-SET" -e "INPUT_MONGODB-PORT" -e "INPUT_MONGODB-DB" -e "INPUT_MONGODB-USERNAME" -e "INPUT_MONGODB-PASSWORD" -e "HOME" -e "GITHUB_JOB" -e "GITHUB_REF" -e "GITHUB_SHA" -e "GITHUB_REPOSITORY" -e "GITHUB_REPOSITORY_OWNER" -e "GITHUB_RUN_ID" -e "GITHUB_RUN_NUMBER" -e "GITHUB_RETENTION_DAYS" -e "GITHUB_RUN_ATTEMPT" -e "GITHUB_ACTOR" -e "GITHUB_TRIGGERING_ACTOR" -e "GITHUB_WORKFLOW" -e "GITHUB_HEAD_REF" -e "GITHUB_BASE_REF" -e "GITHUB_EVENT_NAME" -e "GITHUB_SERVER_URL" -e "GITHUB_API_URL" -e "GITHUB_GRAPHQL_URL" -e "GITHUB_REF_NAME" -e "GITHUB_REF_PROTECTED" -e "GITHUB_REF_TYPE" -e "GITHUB_WORKSPACE" -e "GITHUB_ACTION" -e "GITHUB_EVENT_PATH" -e "GITHUB_ACTION_REPOSITORY" -e "GITHUB_ACTION_REF" -e "GITHUB_PATH" -e "GITHUB_ENV" -e "GITHUB_STEP_SUMMARY" -e "GITHUB_STATE" -e "GITHUB_OUTPUT" -e "RUNNER_OS" -e "RUNNER_ARCH" -e "RUNNER_NAME" -e "RUNNER_TOOL_CACHE" -e "RUNNER_TEMP" -e "RUNNER_WORKSPACE" -e "ACTIONS_RUNTIME_URL" -e "ACTIONS_RUNTIME_TOKEN" -e "ACTIONS_CACHE_URL" -e GITHUB_ACTIONS=true -e CI=true -v "/var/run/docker.sock":"/var/run/docker.sock" -v "/home/runner/work/_temp/_github_home":"/github/home" -v "/home/runner/work/_temp/_github_workflow":"/github/workflow" -v "/home/runner/work/_temp/_runner_file_commands":"/github/file_commands" -v "/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo":"/github/workspace" 290506:47e5fbe7aed248c1a44640d95da64acd  "6.0" "" "27017" "" "" ""
2022-12-30T05:25:44.2292247Z ##[group]Selecting correct MongoDB client
2022-12-30T05:25:44.2374372Z   - Using [mongosh --quiet]
2022-12-30T05:25:44.2376670Z 
2022-12-30T05:25:44.2377307Z ##[endgroup]
2022-12-30T05:25:44.2378608Z ##[group]Starting single-node instance, no replica set
2022-12-30T05:25:44.2380466Z   - port [27017]
2022-12-30T05:25:44.2385800Z   - version [6.0]
2022-12-30T05:25:44.2386097Z   - database []
2022-12-30T05:25:44.2386728Z   - credentials [:]
2022-12-30T05:25:44.2386905Z 
2022-12-30T05:25:44.2675414Z Unable to find image 'mongo:6.0' locally
2022-12-30T05:25:45.2649552Z 6.0: Pulling from library/mongo
2022-12-30T05:25:45.5251864Z 846c0b181fff: Already exists
2022-12-30T05:25:45.5275419Z ef773e84b43a: Pulling fs layer
2022-12-30T05:25:45.5283413Z 2bfad1efb664: Pulling fs layer
2022-12-30T05:25:45.5283968Z 84e59a6d63c9: Pulling fs layer
2022-12-30T05:25:45.5286588Z d2f00ac700e0: Pulling fs layer
2022-12-30T05:25:45.5286815Z 96d33bf42f45: Pulling fs layer
2022-12-30T05:25:45.5287050Z ebaa69d77b61: Pulling fs layer
2022-12-30T05:25:45.5287290Z aa77b709a7d6: Pulling fs layer
2022-12-30T05:25:45.5287511Z 245bd0c9ace2: Pulling fs layer
2022-12-30T05:25:45.5287745Z 96d33bf42f45: Waiting
2022-12-30T05:25:45.5287957Z ebaa69d77b61: Waiting
2022-12-30T05:25:45.5288147Z aa77b709a7d6: Waiting
2022-12-30T05:25:45.5288355Z 245bd0c9ace2: Waiting
2022-12-30T05:25:45.5288558Z d2f00ac700e0: Waiting
2022-12-30T05:25:45.7763199Z ef773e84b43a: Download complete
2022-12-30T05:25:45.7987918Z 84e59a6d63c9: Verifying Checksum
2022-12-30T05:25:45.7988252Z 84e59a6d63c9: Download complete
2022-12-30T05:25:45.8885243Z 2bfad1efb664: Verifying Checksum
2022-12-30T05:25:45.8885567Z 2bfad1efb664: Download complete
2022-12-30T05:25:45.9397858Z ef773e84b43a: Pull complete
2022-12-30T05:25:46.0388701Z d2f00ac700e0: Verifying Checksum
2022-12-30T05:25:46.0389065Z d2f00ac700e0: Download complete
2022-12-30T05:25:46.0517331Z 96d33bf42f45: Verifying Checksum
2022-12-30T05:25:46.0518096Z 96d33bf42f45: Download complete
2022-12-30T05:25:46.1417119Z ebaa69d77b61: Verifying Checksum
2022-12-30T05:25:46.1417497Z ebaa69d77b61: Download complete
2022-12-30T05:25:46.3007263Z 245bd0c9ace2: Verifying Checksum
2022-12-30T05:25:46.3007929Z 245bd0c9ace2: Download complete
2022-12-30T05:25:46.7050685Z 2bfad1efb664: Pull complete
2022-12-30T05:25:46.8997823Z 84e59a6d63c9: Pull complete
2022-12-30T05:25:47.0468794Z d2f00ac700e0: Pull complete
2022-12-30T05:25:47.1413299Z 96d33bf42f45: Pull complete
2022-12-30T05:25:47.2597143Z ebaa69d77b61: Pull complete
2022-12-30T05:25:48.0244290Z aa77b709a7d6: Verifying Checksum
2022-12-30T05:25:48.0244635Z aa77b709a7d6: Download complete
2022-12-30T05:25:56.4686336Z aa77b709a7d6: Pull complete
2022-12-30T05:25:56.5376885Z 245bd0c9ace2: Pull complete
2022-12-30T05:25:56.5443913Z Digest: sha256:c015870b10451c414911aff5648495bd3fcc9fe0cec340f46bb852706697a72f
2022-12-30T05:25:56.5469847Z Status: Downloaded newer image for mongo:6.0
2022-12-30T05:25:56.5711259Z 037d30431341f62554c07c2ce0502f6a49f23c682dcb75f2cf4de94f24ebcd48
2022-12-30T05:25:57.1066647Z ##[endgroup]
2022-12-30T05:25:57.2599467Z ##[group]Run gem install bundler rake
2022-12-30T05:25:57.2599879Z �[36;1mgem install bundler rake�[0m
2022-12-30T05:25:57.2600174Z �[36;1mbundle install --jobs 4 --retry 3�[0m
2022-12-30T05:25:57.2600458Z �[36;1mbundle exec rake test�[0m
2022-12-30T05:25:57.2667502Z shell: /usr/bin/bash -e {0}
2022-12-30T05:25:57.2667761Z env:
2022-12-30T05:25:57.2667973Z   CI: true
2022-12-30T05:25:57.2668198Z ##[endgroup]
2022-12-30T05:25:58.0038252Z Successfully installed bundler-2.4.1
2022-12-30T05:25:58.0040134Z Successfully installed rake-13.0.6
2022-12-30T05:25:58.0040660Z 2 gems installed
2022-12-30T05:25:59.7248656Z Fetching gem metadata from https://rubygems.org/......
2022-12-30T05:25:59.7611266Z Resolving dependencies...
2022-12-30T05:25:59.8975795Z Using rake 13.0.6
2022-12-30T05:25:59.8988922Z Using bundler 2.4.1
2022-12-30T05:25:59.8993152Z Fetching cool.io 1.7.1
2022-12-30T05:25:59.9030839Z Fetching bson 4.15.0
2022-12-30T05:25:59.9031950Z Fetching concurrent-ruby 1.1.10
2022-12-30T05:25:59.9055615Z Fetching docile 1.4.0
2022-12-30T05:25:59.9897225Z Installing docile 1.4.0
2022-12-30T05:25:59.9971956Z Installing cool.io 1.7.1 with native extensions
2022-12-30T05:26:00.0163252Z Installing bson 4.15.0 with native extensions
2022-12-30T05:26:00.0212115Z Fetching http_parser.rb 0.8.0
2022-12-30T05:26:00.0558302Z Installing concurrent-ruby 1.1.10
2022-12-30T05:26:00.1279418Z Installing http_parser.rb 0.8.0 with native extensions
2022-12-30T05:26:00.2160606Z Fetching msgpack 1.6.0
2022-12-30T05:26:00.2614985Z Installing msgpack 1.6.0 with native extensions
2022-12-30T05:26:03.6273787Z Fetching sigdump 0.2.4
2022-12-30T05:26:03.6577981Z Installing sigdump 0.2.4
2022-12-30T05:26:03.6677821Z Fetching strptime 0.2.5
2022-12-30T05:26:03.6977658Z Installing strptime 0.2.5 with native extensions
2022-12-30T05:26:04.4051188Z Fetching webrick 1.7.0
2022-12-30T05:26:04.4674824Z Installing webrick 1.7.0
2022-12-30T05:26:04.5203461Z Fetching yajl-ruby 1.4.3
2022-12-30T05:26:04.6022362Z Installing yajl-ruby 1.4.3 with native extensions
2022-12-30T05:26:08.0856631Z Fetching power_assert 2.0.3
2022-12-30T05:26:08.1294028Z Installing power_assert 2.0.3
2022-12-30T05:26:08.1429255Z Fetching rr 3.1.0
2022-12-30T05:26:08.1868562Z Installing rr 3.1.0
2022-12-30T05:26:08.3358827Z Fetching simplecov-html 0.12.3
2022-12-30T05:26:08.3970313Z Installing simplecov-html 0.12.3
2022-12-30T05:26:08.4586854Z Fetching simplecov_json_formatter 0.1.4
2022-12-30T05:26:08.4865271Z Installing simplecov_json_formatter 0.1.4
2022-12-30T05:26:08.4962516Z Fetching timecop 0.9.6
2022-12-30T05:26:08.5313703Z Installing timecop 0.9.6
2022-12-30T05:26:08.5443591Z Fetching tzinfo 2.0.5
2022-12-30T05:26:08.5788361Z Installing tzinfo 2.0.5
2022-12-30T05:26:08.6163201Z Fetching serverengine 2.3.1
2022-12-30T05:26:08.6451135Z Installing serverengine 2.3.1
2022-12-30T05:26:08.6818555Z Fetching mongo 2.18.2
2022-12-30T05:26:08.8843440Z Installing mongo 2.18.2
2022-12-30T05:26:09.8408124Z Fetching test-unit 3.5.7
2022-12-30T05:26:09.8771303Z Installing test-unit 3.5.7
2022-12-30T05:26:09.9353909Z Fetching simplecov 0.22.0
2022-12-30T05:26:09.9743411Z Installing simplecov 0.22.0
2022-12-30T05:26:09.9784991Z Fetching tzinfo-data 1.2022.7
2022-12-30T05:26:10.0378002Z Installing tzinfo-data 1.2022.7
2022-12-30T05:26:12.2061670Z Fetching fluentd 1.15.3
2022-12-30T05:26:12.3391169Z Installing fluentd 1.15.3
2022-12-30T05:26:12.5027596Z Using fluent-plugin-mongo 1.6.0 from source at `.` and installing its executables
2022-12-30T05:26:12.5086476Z Bundle complete! 7 Gemfile dependencies, 25 gems now installed.
2022-12-30T05:26:12.5086916Z Use `bundle info [gemname]` to see where a bundled gem is installed.
2022-12-30T05:26:13.0030861Z /opt/hostedtoolcache/Ruby/3.0.5/x64/bin/ruby -w -I"lib:test" /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/rake-13.0.6/lib/rake/rake_test_loader.rb "test/plugin/test_in_mongo_tail.rb" "test/plugin/test_out_mongo.rb" "test/plugin/test_out_mongo_replset.rb" 
2022-12-30T05:26:13.2772834Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_in_mongo_tail.rb:164: warning: assigned but unused variable - d
2022-12-30T05:26:13.7252383Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper.rb:46: warning: method redefined; discarding old inherited
2022-12-30T05:26:13.7253598Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper.rb:46: warning: previous definition of inherited was here
2022-12-30T05:26:13.7798985Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson/decimal128/builder.rb:192: warning: assigned but unused variable - original
2022-12-30T05:26:13.7800050Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson/decimal128/builder.rb:193: warning: assigned but unused variable - e
2022-12-30T05:26:13.7800908Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson/decimal128/builder.rb:194: warning: assigned but unused variable - decimal
2022-12-30T05:26:13.7801651Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson/decimal128/builder.rb:320: warning: assigned but unused variable - base
2022-12-30T05:26:13.7995263Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson_native.so: warning: method redefined; discarding old next_object_id
2022-12-30T05:26:13.7996527Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/bson-4.15.0/lib/bson/object_id.rb:371: warning: previous definition of next_object_id was here
2022-12-30T05:26:13.9273419Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/auth/aws/conversation.rb:79: warning: method redefined; discarding old client_first_payload
2022-12-30T05:26:13.9274822Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/auth/aws/conversation.rb:68: warning: previous definition of client_first_payload was here
2022-12-30T05:26:13.9281760Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/auth/aws/request.rb:218: warning: assigned but unused variable - hashed_body
2022-12-30T05:26:13.9497527Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/cluster/sdam_flow.rb:368: warning: assigned but unused variable - address_strs
2022-12-30T05:26:13.9653040Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/collection/view/change_stream.rb:167: warning: assigned but unused variable - e
2022-12-30T05:26:13.9686215Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/collection/view/readable.rb:277: warning: mismatched indentations at 'end' with 'if' at 274
2022-12-30T05:26:13.9747045Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/database/view.rb:175: warning: assigned but unused variable - docs
2022-12-30T05:26:14.0021759Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/connection_pool.rb:808: warning: assigned but unused variable - connection
2022-12-30T05:26:14.0053983Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/description.rb:848: warning: method redefined; discarding old service_id
2022-12-30T05:26:14.0058765Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/description.rb:303: warning: previous definition of service_id was here
2022-12-30T05:26:14.0297094Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/srv/monitor.rb:73: warning: assigned but unused variable - old_hosts
2022-12-30T05:26:14.0299571Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/timeout.rb:39: warning: assigned but unused variable - e
2022-12-30T05:26:14.0305998Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/uri.rb:238: warning: assigned but unused variable - remaining
2022-12-30T05:26:14.0506816Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_out_mongo.rb:86: warning: assigned but unused variable - d
2022-12-30T05:26:14.0507689Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_out_mongo.rb:107: warning: assigned but unused variable - d
2022-12-30T05:26:14.0512314Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_out_mongo.rb:412: warning: assigned but unused variable - d
2022-12-30T05:26:14.0690316Z Loaded suite /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/rake-13.0.6/lib/rake/rake_test_loader
2022-12-30T05:26:14.0998274Z Started
2022-12-30T05:26:17.8492658Z #<Thread:0x0000557eb48b5ca8@flush_thread_0 /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper/thread.rb:70 run> terminated with exception (report_on_exception is true):
2022-12-30T05:26:17.8509802Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:364:in `raise_operation_failure': [67:CannotCreateIndex]: Cannot create TTL index on a capped collection (on localhost:27017) (Mongo::Error::OperationFailure)
2022-12-30T05:26:17.8521709Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:330:in `validate!'
2022-12-30T05:26:17.8526798Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:36:in `block (3 levels) in validate_result'
2022-12-30T05:26:17.8528342Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:108:in `add_server_diagnostics'
2022-12-30T05:26:17.8529567Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:35:in `block (2 levels) in validate_result'
2022-12-30T05:26:17.8530400Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:54:in `add_error_labels'
2022-12-30T05:26:17.8531141Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:34:in `block in validate_result'
2022-12-30T05:26:17.8532003Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:94:in `unpin_maybe'
2022-12-30T05:26:17.8532739Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:33:in `validate_result'
2022-12-30T05:26:17.8533443Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:81:in `block in execute'
2022-12-30T05:26:17.8533854Z 	from <internal:kernel>:90:in `tap'
2022-12-30T05:26:17.8534425Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:80:in `execute'
2022-12-30T05:26:17.8535168Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:49:in `execute_with_connection'
2022-12-30T05:26:17.8536080Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:36:in `block in execute'
2022-12-30T05:26:17.8536721Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/connection_pool.rb:667:in `with_connection'
2022-12-30T05:26:17.8537316Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server.rb:448:in `with_connection'
2022-12-30T05:26:17.8537932Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:35:in `execute'
2022-12-30T05:26:17.8538595Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:233:in `block in create_many'
2022-12-30T05:26:17.8539307Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/client.rb:1132:in `with_session'
2022-12-30T05:26:17.8539899Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:213:in `create_many'
2022-12-30T05:26:17.8540467Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:169:in `create_one'
2022-12-30T05:26:17.8541045Z 	from /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:328:in `get_collection'
2022-12-30T05:26:17.8541653Z 	from /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:355:in `operate'
2022-12-30T05:26:17.8542253Z 	from /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:205:in `write'
2022-12-30T05:26:17.8542979Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1180:in `try_flush'
2022-12-30T05:26:17.8543617Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1501:in `flush_thread_run'
2022-12-30T05:26:17.8544286Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:501:in `block (2 levels) in start'
2022-12-30T05:26:17.8544972Z 	from /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper/thread.rb:78:in `block in thread_create'
2022-12-30T05:26:17.8586150Z �[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0mE, [2022-12-30T05:26:17.856930 #2820] ERROR -- : unexpected error while after_shutdown, Mongo::Error::OperationFailure:[67:CannotCreateIndex]: Cannot create TTL index on a capped collection (on localhost:27017)
2022-12-30T05:26:17.8587409Z E, [2022-12-30T05:26:17.856980 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:364:in `raise_operation_failure'
2022-12-30T05:26:17.8588278Z E, [2022-12-30T05:26:17.856995 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:330:in `validate!'
2022-12-30T05:26:17.8589121Z E, [2022-12-30T05:26:17.857006 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:36:in `block (3 levels) in validate_result'
2022-12-30T05:26:17.8589992Z E, [2022-12-30T05:26:17.857015 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:108:in `add_server_diagnostics'
2022-12-30T05:26:17.8590961Z E, [2022-12-30T05:26:17.857024 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:35:in `block (2 levels) in validate_result'
2022-12-30T05:26:17.8591870Z E, [2022-12-30T05:26:17.857045 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:54:in `add_error_labels'
2022-12-30T05:26:17.8592619Z E, [2022-12-30T05:26:17.857054 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:34:in `block in validate_result'
2022-12-30T05:26:17.8593368Z E, [2022-12-30T05:26:17.857063 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:94:in `unpin_maybe'
2022-12-30T05:26:17.8594111Z E, [2022-12-30T05:26:17.857071 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:33:in `validate_result'
2022-12-30T05:26:17.8595225Z E, [2022-12-30T05:26:17.857145 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:81:in `block in execute'
2022-12-30T05:26:17.8596185Z E, [2022-12-30T05:26:17.857160 #2820] ERROR -- : 	<internal:kernel>:90:in `tap'
2022-12-30T05:26:17.8596884Z E, [2022-12-30T05:26:17.857170 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:80:in `execute'
2022-12-30T05:26:17.8597861Z E, [2022-12-30T05:26:17.857179 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:49:in `execute_with_connection'
2022-12-30T05:26:17.8605360Z E, [2022-12-30T05:26:17.857189 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:36:in `block in execute'
2022-12-30T05:26:17.8608629Z E, [2022-12-30T05:26:17.857198 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/connection_pool.rb:667:in `with_connection'
2022-12-30T05:26:17.8609906Z E, [2022-12-30T05:26:17.857207 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server.rb:448:in `with_connection'
2022-12-30T05:26:17.8610706Z E, [2022-12-30T05:26:17.857217 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:35:in `execute'
2022-12-30T05:26:17.8611499Z E, [2022-12-30T05:26:17.857226 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:233:in `block in create_many'
2022-12-30T05:26:17.8612471Z E, [2022-12-30T05:26:17.857234 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/client.rb:1132:in `with_session'
2022-12-30T05:26:17.8613218Z E, [2022-12-30T05:26:17.857243 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:213:in `create_many'
2022-12-30T05:26:17.8614158Z E, [2022-12-30T05:26:17.857252 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:169:in `create_one'
2022-12-30T05:26:17.8614878Z E, [2022-12-30T05:26:17.857261 #2820] ERROR -- : 	/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:328:in `get_collection'
2022-12-30T05:26:17.8615608Z E, [2022-12-30T05:26:17.857270 #2820] ERROR -- : 	/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:355:in `operate'
2022-12-30T05:26:17.8616970Z E, [2022-12-30T05:26:17.857279 #2820] ERROR -- : 	/home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:205:in `write'
2022-12-30T05:26:17.8621515Z E, [2022-12-30T05:26:17.857288 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1180:in `try_flush'
2022-12-30T05:26:17.8622338Z E, [2022-12-30T05:26:17.857297 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1501:in `flush_thread_run'
2022-12-30T05:26:17.8623126Z E, [2022-12-30T05:26:17.857305 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:501:in `block (2 levels) in start'
2022-12-30T05:26:17.8623924Z E, [2022-12-30T05:26:17.857315 #2820] ERROR -- : 	/opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper/thread.rb:78:in `block in thread_create'
2022-12-30T05:26:17.8624373Z �[38;5;226mE�[0m
2022-12-30T05:26:17.8624615Z ===============================================================================
2022-12-30T05:26:17.8625843Z Error: �[48;5;16;38;5;226;1mtest_write_with_expire_index(MongoOutputTest)�[0m: Mongo::Error::OperationFailure: [67:CannotCreateIndex]: Cannot create TTL index on a capped collection (on localhost:27017)
2022-12-30T05:26:17.8626664Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:364:in `raise_operation_failure'
2022-12-30T05:26:17.8627329Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/result.rb:330:in `validate!'
2022-12-30T05:26:17.8628045Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:36:in `block (3 levels) in validate_result'
2022-12-30T05:26:17.8628913Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:108:in `add_server_diagnostics'
2022-12-30T05:26:17.8629663Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:35:in `block (2 levels) in validate_result'
2022-12-30T05:26:17.8630377Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:54:in `add_error_labels'
2022-12-30T05:26:17.8631091Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:34:in `block in validate_result'
2022-12-30T05:26:17.8632674Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:94:in `unpin_maybe'
2022-12-30T05:26:17.8633437Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/response_handling.rb:33:in `validate_result'
2022-12-30T05:26:17.8634372Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:81:in `block in execute'
2022-12-30T05:26:17.8634783Z <internal:kernel>:90:in `tap'
2022-12-30T05:26:17.8635338Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/executable.rb:80:in `execute'
2022-12-30T05:26:17.8636447Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:49:in `execute_with_connection'
2022-12-30T05:26:17.8637207Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:36:in `block in execute'
2022-12-30T05:26:17.8638245Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server/connection_pool.rb:667:in `with_connection'
2022-12-30T05:26:17.8639235Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/server.rb:448:in `with_connection'
2022-12-30T05:26:17.8650159Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/operation/shared/op_msg_executable.rb:35:in `execute'
2022-12-30T05:26:17.8657609Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:233:in `block in create_many'
2022-12-30T05:26:17.8658418Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/client.rb:1132:in `with_session'
2022-12-30T05:26:17.8659029Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:213:in `create_many'
2022-12-30T05:26:17.8659647Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/mongo-2.18.2/lib/mongo/index/view.rb:169:in `create_one'
2022-12-30T05:26:17.8660403Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:328:in `get_collection'
2022-12-30T05:26:17.8661230Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:355:in `operate'
2022-12-30T05:26:17.8661839Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/lib/fluent/plugin/out_mongo.rb:205:in `write'
2022-12-30T05:26:17.8663897Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1180:in `try_flush'
2022-12-30T05:26:17.8664729Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:1501:in `flush_thread_run'
2022-12-30T05:26:17.8665374Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin/output.rb:501:in `block (2 levels) in start'
2022-12-30T05:26:17.8666146Z /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/fluentd-1.15.3/lib/fluent/plugin_helper/thread.rb:78:in `block in thread_create'
2022-12-30T05:26:19.0458270Z ===============================================================================
2022-12-30T05:26:31.5867137Z �[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;17mO�[0m
2022-12-30T05:26:31.5867893Z ===============================================================================
2022-12-30T05:26:31.5869534Z Omission: �[48;5;17;38;5;231;1mReplica set setup is too hard in CI.�[0m [test_write(MongoReplsetOutputTest::ReplisetWriteTest)]
2022-12-30T05:26:31.5870240Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_out_mongo_replset.rb:91:in `setup'
2022-12-30T05:26:31.5878919Z ===============================================================================
2022-12-30T05:26:31.5879603Z �[38;5;17mO�[0m
2022-12-30T05:26:31.5879859Z ===============================================================================
2022-12-30T05:26:31.5882269Z Omission: �[48;5;17;38;5;231;1mReplica set setup is too hard in CI.�[0m [test_write(MongoReplsetOutputTest::ReplisetWriteTest)]
2022-12-30T05:26:31.5883913Z /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo/test/plugin/test_out_mongo_replset.rb:97:in `teardown'
2022-12-30T05:26:31.5975518Z ===============================================================================
2022-12-30T05:26:36.4012145Z �[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m�[38;5;46;1m.�[0m
2022-12-30T05:26:36.4014318Z Finished in 22.332342911 seconds.
2022-12-30T05:26:36.4017512Z �[38;5;226m-------------------------------------------------------------------------------�[0m
2022-12-30T05:26:36.4018610Z 36 tests, 87 assertions, 0 failures, 1 errors, 0 pendings, 2 omissions, 0 notifications
2022-12-30T05:26:36.4158310Z 100% passed
2022-12-30T05:26:36.4159089Z �[38;5;226m-------------------------------------------------------------------------------�[0m
2022-12-30T05:26:36.4335054Z 1.61 tests/s, 3.90 assertions/s
2022-12-30T05:26:36.4474352Z rake aborted!
2022-12-30T05:26:36.4475367Z Command failed with status (1): [ruby -w -I"lib:test" /opt/hostedtoolcache/Ruby/3.0.5/x64/lib/ruby/gems/3.0.0/gems/rake-13.0.6/lib/rake/rake_test_loader.rb "test/plugin/test_in_mongo_tail.rb" "test/plugin/test_out_mongo.rb" "test/plugin/test_out_mongo_replset.rb" ]
2022-12-30T05:26:36.4479076Z /opt/hostedtoolcache/Ruby/3.0.5/x64/bin/bundle:23:in `load'
2022-12-30T05:26:36.4479626Z /opt/hostedtoolcache/Ruby/3.0.5/x64/bin/bundle:23:in `<main>'
2022-12-30T05:26:36.4480160Z Tasks: TOP => test
2022-12-30T05:26:36.4480786Z (See full trace by running task with --trace)
2022-12-30T05:26:36.4530204Z ##[error]Process completed with exit code 1.
2022-12-30T05:26:36.4596491Z Post job cleanup.
2022-12-30T05:26:36.6137663Z [command]/usr/bin/git version
2022-12-30T05:26:36.6208237Z git version 2.38.2
2022-12-30T05:26:36.6286699Z Temporarily overriding HOME='/home/runner/work/_temp/30ba1026-38c4-43aa-8bda-df9753398dbe' before making global git config changes
2022-12-30T05:26:36.6293488Z Adding repository directory to the temporary git global config as a safe directory
2022-12-30T05:26:36.6303343Z [command]/usr/bin/git config --global --add safe.directory /home/runner/work/fluent-plugin-mongo/fluent-plugin-mongo
2022-12-30T05:26:36.6376734Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand
2022-12-30T05:26:36.6412174Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || :"
2022-12-30T05:26:36.6705647Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader
2022-12-30T05:26:36.6728471Z http.https://github.com/.extraheader
2022-12-30T05:26:36.6743563Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader
2022-12-30T05:26:36.6788263Z [command]/usr/bin/git submodule foreach --recursive sh -c "git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :"
2022-12-30T05:26:36.7340803Z Cleaning up orphan processes