Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Action is pulling in binary files in a repo #174

Closed
CalvinRodo opened this issue Feb 17, 2022 · 15 comments · Fixed by #163
Closed

Action is pulling in binary files in a repo #174

CalvinRodo opened this issue Feb 17, 2022 · 15 comments · Fixed by #163
Labels
bug Something isn't working

Comments

@CalvinRodo
Copy link

CalvinRodo commented Feb 17, 2022

🐞 Describe the bug
Syncing a file in a repo that has binary files will include those binary files in the PR and also modifies them.

Bug is recreated in this repo:

https://github.com/cds-snc/sre-test-repo

Here is the PR:
cds-snc/sre-test-repo#2

Please note this PR was triggered by another repo just to prove that it does occur in normal usage instead of just in the repo it was run in as I originally reported.

📚 To Reproduce

  • authenticate using a Token from a GitHub App installation

  • Add a binary file to a repo.

To create a basic binary file run the following command in bash

echo "00000000: ff" | xxd -r - binary.dat
  • Run the action and the binary file will be apart of the PR even if it is not part of the configuration.

💡 Expected behavior

I expect only the files identified to show up in the repo.

🖼️ Screenshots

Screen shot of files in PR in case it dissapears.

image

⚙️ Environment
We pin Git SHA

📋 Additional context

It converted a basic binary file from in hex, so I imagine there might be an issue with binary files and this action.

FF 0F to EF BF BD 0F

I also ran into an issue with a larger binary file, when using an image of about 960kb ran into the following error:
stdout maxBuffer length exceeded

Some test runs:

@CalvinRodo CalvinRodo added the bug Something isn't working label Feb 17, 2022
@CalvinRodo CalvinRodo changed the title Syncing a file in the same repo ended up commiting unexpected binary files. Action is pulling in binary files in a repo Feb 18, 2022
@BetaHuhn
Copy link
Owner

BetaHuhn commented Feb 18, 2022

Hi @CalvinRodo, thanks for reporting this and taking the time to debug it. Could you enable the step debug logging by setting the ACTIONS_STEP_DEBUG secret to true and try again? It should output some more debugging information to help us see what exactly goes wrong.

I am not sure why it is including those binary files, looking at your sync.yml config it shouldn't do that.

@alvarezfr, the action will use the GitHub API to push the changes because a installation token is used, but throws Error: stdout maxBuffer length exceeded (ERR_CHILD_PROCESS_STDIO_MAXBUFFER ) when trying to do that. Since you implemented that, could you take a look at what might cause that? Could this be fixed with your PR #163?

@CalvinRodo
Copy link
Author

I'll try with a PAT as well and see if I can recreate

@CalvinRodo
Copy link
Author

CalvinRodo commented Feb 18, 2022

Just tested with a PAT and it worked as expected so can confirm this is for using Installation Token auth only.

@CalvinRodo
Copy link
Author

CalvinRodo commented Feb 18, 2022

Raw Logs using a GH App:

Debug logs...

``` 2022-02-18T17:55:26.7147986Z Requested labels: ubuntu-latest 2022-02-18T17:55:26.7148035Z Job defined at: cds-snc/sre-test-repo/.github/workflows/sre-file-sync.yml@refs/heads/main 2022-02-18T17:55:26.7148055Z Waiting for a runner to pick up this job... 2022-02-18T17:55:27.3419373Z Job is waiting for a hosted runner to come online. 2022-02-18T17:55:31.1878351Z Job is about to start running on the hosted runner: Hosted Agent (hosted) 2022-02-18T17:55:34.5223586Z ##[debug]Starting: sync_backup_workflow 2022-02-18T17:55:34.5257642Z ##[debug]Cleaning runner temp folder: /home/runner/work/_temp 2022-02-18T17:55:34.5583062Z ##[debug]Starting: Set up job 2022-02-18T17:55:34.5583696Z Current runner version: '2.287.1' 2022-02-18T17:55:34.5608761Z ##[group]Operating System 2022-02-18T17:55:34.5609574Z Ubuntu 2022-02-18T17:55:34.5610028Z 20.04.3 2022-02-18T17:55:34.5610554Z LTS 2022-02-18T17:55:34.5611359Z ##[endgroup] 2022-02-18T17:55:34.5612177Z ##[group]Virtual Environment 2022-02-18T17:55:34.5613105Z Environment: ubuntu-20.04 2022-02-18T17:55:34.5613684Z Version: 20220213.1 2022-02-18T17:55:34.5614556Z Included Software: https://github.com/actions/virtual-environments/blob/ubuntu20/20220213.1/images/linux/Ubuntu2004-Readme.md 2022-02-18T17:55:34.5615992Z Image Release: https://github.com/actions/virtual-environments/releases/tag/ubuntu20%2F20220213.1 2022-02-18T17:55:34.5616715Z ##[endgroup] 2022-02-18T17:55:34.5617238Z ##[group]Virtual Environment Provisioner 2022-02-18T17:55:34.5618254Z 1.0.0.0-main-20220202-1 2022-02-18T17:55:34.5618935Z ##[endgroup] 2022-02-18T17:55:34.5620319Z ##[group]GITHUB_TOKEN Permissions 2022-02-18T17:55:34.5621418Z Actions: write 2022-02-18T17:55:34.5621896Z Checks: write 2022-02-18T17:55:34.5622433Z Contents: write 2022-02-18T17:55:34.5623298Z Deployments: write 2022-02-18T17:55:34.5624438Z Discussions: write 2022-02-18T17:55:34.5624995Z Issues: write 2022-02-18T17:55:34.5625601Z Metadata: read 2022-02-18T17:55:34.5626199Z Packages: write 2022-02-18T17:55:34.5627151Z Pages: write 2022-02-18T17:55:34.5627979Z PullRequests: write 2022-02-18T17:55:34.5628534Z RepositoryProjects: write 2022-02-18T17:55:34.5629307Z SecurityEvents: write 2022-02-18T17:55:34.5629840Z Statuses: write 2022-02-18T17:55:34.5630388Z ##[endgroup] 2022-02-18T17:55:34.5634638Z Secret source: Actions 2022-02-18T17:55:34.5636303Z ##[debug]Primary repository: cds-snc/sre-test-repo 2022-02-18T17:55:34.5637029Z Prepare workflow directory 2022-02-18T17:55:34.5732455Z ##[debug]Creating pipeline directory: '/home/runner/work/sre-test-repo' 2022-02-18T17:55:34.5737897Z ##[debug]Creating workspace directory: '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T17:55:34.5742503Z ##[debug]Update context data 2022-02-18T17:55:34.5747067Z ##[debug]Evaluating job-level environment variables 2022-02-18T17:55:34.6540688Z ##[debug]Evaluating job container 2022-02-18T17:55:34.6544018Z ##[debug]Evaluating job service containers 2022-02-18T17:55:34.6547003Z ##[debug]Evaluating job defaults 2022-02-18T17:55:34.6644114Z Prepare all required actions 2022-02-18T17:55:34.6872235Z Getting action download info 2022-02-18T17:55:34.8884291Z Download action repository 'actions/checkout@v2' (SHA:ec3a7ce113134d7a93b817d10a8272cb61118579) 2022-02-18T17:55:35.0797776Z ##[debug]Download 'https://api.github.com/repos/actions/checkout/tarball/ec3a7ce113134d7a93b817d10a8272cb61118579' to '/home/runner/work/_actions/_temp_ed54eb97-69b8-4af6-a235-e33aed9524a4/a3f8c34d-a626-45a2-bbc3-815f4a634688.tar.gz' 2022-02-18T17:55:35.2081008Z ##[debug]Unwrap 'actions-checkout-ec3a7ce' to '/home/runner/work/_actions/actions/checkout/v2' 2022-02-18T17:55:35.2277390Z ##[debug]Archive '/home/runner/work/_actions/_temp_ed54eb97-69b8-4af6-a235-e33aed9524a4/a3f8c34d-a626-45a2-bbc3-815f4a634688.tar.gz' has been unzipped into '/home/runner/work/_actions/actions/checkout/v2'. 2022-02-18T17:55:35.2438717Z Download action repository 'tibdex/github-app-token@7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' (SHA:7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4) 2022-02-18T17:55:35.3957608Z ##[debug]Download 'https://api.github.com/repos/tibdex/github-app-token/tarball/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' to '/home/runner/work/_actions/_temp_a35cc733-847c-47a0-b4a0-01224b3f6fdf/065ab9c6-6a31-4dd2-8a94-c81dc4c4984b.tar.gz' 2022-02-18T17:55:35.4104627Z ##[debug]Unwrap 'tibdex-github-app-token-7ce9ffd' to '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' 2022-02-18T17:55:35.4118980Z ##[debug]Archive '/home/runner/work/_actions/_temp_a35cc733-847c-47a0-b4a0-01224b3f6fdf/065ab9c6-6a31-4dd2-8a94-c81dc4c4984b.tar.gz' has been unzipped into '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4'. 2022-02-18T17:55:35.4132681Z Download action repository 'BetaHuhn/repo-file-sync-action@878d649' (SHA:878d649c33c834dc1eff4c00f7fcf16bf281eb63) 2022-02-18T17:55:35.6414308Z ##[debug]Download 'https://api.github.com/repos/BetaHuhn/repo-file-sync-action/tarball/878d649c33c834dc1eff4c00f7fcf16bf281eb63' to '/home/runner/work/_actions/_temp_850727fd-862e-42a8-a210-a456ddf83ecf/59c5cc19-a221-40e3-a65a-a513a39f7664.tar.gz' 2022-02-18T17:55:35.6600820Z ##[debug]Unwrap 'BetaHuhn-repo-file-sync-action-878d649' to '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63' 2022-02-18T17:55:35.6652235Z ##[debug]Archive '/home/runner/work/_actions/_temp_850727fd-862e-42a8-a210-a456ddf83ecf/59c5cc19-a221-40e3-a65a-a513a39f7664.tar.gz' has been unzipped into '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63'. 2022-02-18T17:55:35.6735543Z ##[debug]action.yml for action: '/home/runner/work/_actions/actions/checkout/v2/action.yml'. 2022-02-18T17:55:35.7923382Z ##[debug]action.yml for action: '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4/action.yml'. 2022-02-18T17:55:35.7960855Z ##[debug]action.yml for action: '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63/action.yml'. 2022-02-18T17:55:35.8215435Z ##[debug]Set step '__actions_checkout' display name to: 'Run actions/checkout@v2' 2022-02-18T17:55:35.8219782Z ##[debug]Set step 'generate_token' display name to: 'impersonate SRE Read/Write GH App' 2022-02-18T17:55:35.8222744Z ##[debug]Set step '__BetaHuhn_repo-file-sync-action' display name to: 'Sync SRE Workflows' 2022-02-18T17:55:35.8238572Z ##[debug]Collect running processes for tracking orphan processes. 2022-02-18T17:55:35.8665057Z ##[debug]Finishing: Set up job 2022-02-18T17:55:35.8845998Z ##[debug]Evaluating condition for step: 'Run actions/checkout@v2' 2022-02-18T17:55:35.8917989Z ##[debug]Evaluating: success() 2022-02-18T17:55:35.8925533Z ##[debug]Evaluating success: 2022-02-18T17:55:35.8958427Z ##[debug]=> true 2022-02-18T17:55:35.8968940Z ##[debug]Result: true 2022-02-18T17:55:35.9021122Z ##[debug]Starting: Run actions/checkout@v2 2022-02-18T17:55:35.9179847Z ##[debug]Register post job cleanup for action: actions/checkout@v2 2022-02-18T17:55:35.9309271Z ##[debug]Loading inputs 2022-02-18T17:55:35.9325038Z ##[debug]Evaluating: github.repository 2022-02-18T17:55:35.9326486Z ##[debug]Evaluating Index: 2022-02-18T17:55:35.9331267Z ##[debug]..Evaluating github: 2022-02-18T17:55:35.9333692Z ##[debug]..=> Object 2022-02-18T17:55:35.9349501Z ##[debug]..Evaluating String: 2022-02-18T17:55:35.9350600Z ##[debug]..=> 'repository' 2022-02-18T17:55:35.9356028Z ##[debug]=> 'cds-snc/sre-test-repo' 2022-02-18T17:55:35.9358295Z ##[debug]Result: 'cds-snc/sre-test-repo' 2022-02-18T17:55:35.9361271Z ##[debug]Evaluating: github.token 2022-02-18T17:55:35.9361772Z ##[debug]Evaluating Index: 2022-02-18T17:55:35.9362266Z ##[debug]..Evaluating github: 2022-02-18T17:55:35.9363032Z ##[debug]..=> Object 2022-02-18T17:55:35.9363658Z ##[debug]..Evaluating String: 2022-02-18T17:55:35.9365137Z ##[debug]..=> 'token' 2022-02-18T17:55:35.9366375Z ##[debug]=> '***' 2022-02-18T17:55:35.9367013Z ##[debug]Result: '***' 2022-02-18T17:55:35.9376863Z ##[debug]Loading env 2022-02-18T17:55:35.9502585Z ##[group]Run actions/checkout@v2 2022-02-18T17:55:35.9503083Z with: 2022-02-18T17:55:35.9503546Z repository: cds-snc/sre-test-repo 2022-02-18T17:55:35.9504254Z token: *** 2022-02-18T17:55:35.9504704Z ssh-strict: true 2022-02-18T17:55:35.9505166Z persist-credentials: true 2022-02-18T17:55:35.9505601Z clean: true 2022-02-18T17:55:35.9506030Z fetch-depth: 1 2022-02-18T17:55:35.9506453Z lfs: false 2022-02-18T17:55:35.9506881Z submodules: false 2022-02-18T17:55:35.9507611Z ##[endgroup] 2022-02-18T17:55:36.1845281Z ::save-state name=isPost::true 2022-02-18T17:55:36.1850861Z ##[debug]Save intra-action state isPost = true 2022-02-18T17:55:36.2370815Z ##[debug]GITHUB_WORKSPACE = '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T17:55:36.2372234Z ##[debug]qualified repository = 'cds-snc/sre-test-repo' 2022-02-18T17:55:36.2373052Z ##[debug]ref = 'refs/heads/main' 2022-02-18T17:55:36.2373999Z ##[debug]commit = '073497227b9162f7add1591442c0973a32c045e5' 2022-02-18T17:55:36.2375325Z ##[debug]clean = true 2022-02-18T17:55:36.2376023Z ##[debug]fetch depth = 1 2022-02-18T17:55:36.2376963Z ##[debug]lfs = false 2022-02-18T17:55:36.2377980Z ##[debug]submodules = false 2022-02-18T17:55:36.2378825Z ##[debug]recursive submodules = false 2022-02-18T17:55:36.2402484Z ::add-matcher::/home/runner/work/_actions/actions/checkout/v2/dist/problem-matcher.json 2022-02-18T17:55:36.2540637Z ##[debug]Added matchers: 'checkout-git'. Problem matchers scan action output for known warning or error strings and report these inline. 2022-02-18T17:55:36.2552372Z Syncing repository: cds-snc/sre-test-repo 2022-02-18T17:55:36.2555843Z ::group::Getting Git version info 2022-02-18T17:55:36.2558075Z ##[group]Getting Git version info 2022-02-18T17:55:36.2560043Z Working directory is '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T17:55:36.2562080Z ##[debug]Getting git version 2022-02-18T17:55:36.2562821Z [command]/usr/bin/git version 2022-02-18T17:55:36.2687331Z git version 2.35.1 2022-02-18T17:55:36.2712573Z ##[debug]Set git useragent to: git/2.35.1 (github-actions-checkout) 2022-02-18T17:55:36.2714077Z ::endgroup:: 2022-02-18T17:55:36.2714906Z ##[endgroup] 2022-02-18T17:55:36.2724471Z Deleting the contents of '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T17:55:36.2729278Z ::save-state name=repositoryPath::/home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T17:55:36.2730083Z ##[debug]Save intra-action state repositoryPath = /home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T17:55:36.2732355Z ::group::Initializing the repository 2022-02-18T17:55:36.2732943Z ##[group]Initializing the repository 2022-02-18T17:55:36.2738060Z [command]/usr/bin/git init /home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T17:55:36.2835375Z hint: Using 'master' as the name for the initial branch. This default branch name 2022-02-18T17:55:36.2861206Z hint: is subject to change. To configure the initial branch name to use in all 2022-02-18T17:55:36.2862104Z hint: of your new repositories, which will suppress this warning, call: 2022-02-18T17:55:36.2862974Z hint: 2022-02-18T17:55:36.2863764Z hint: git config --global init.defaultBranch 2022-02-18T17:55:36.2864230Z hint: 2022-02-18T17:55:36.2864785Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and 2022-02-18T17:55:36.2865506Z hint: 'development'. The just-created branch can be renamed via this command: 2022-02-18T17:55:36.2866257Z hint: 2022-02-18T17:55:36.2866757Z hint: git branch -m 2022-02-18T17:55:36.2868406Z Initialized empty Git repository in /home/runner/work/sre-test-repo/sre-test-repo/.git/ 2022-02-18T17:55:36.2873877Z [command]/usr/bin/git remote add origin https://github.com/cds-snc/sre-test-repo 2022-02-18T17:55:36.2921003Z ::endgroup:: 2022-02-18T17:55:36.2921421Z ##[endgroup] 2022-02-18T17:55:36.2922691Z ::group::Disabling automatic garbage collection 2022-02-18T17:55:36.2923223Z ##[group]Disabling automatic garbage collection 2022-02-18T17:55:36.2926533Z [command]/usr/bin/git config --local gc.auto 0 2022-02-18T17:55:36.2969639Z ::endgroup:: 2022-02-18T17:55:36.2970060Z ##[endgroup] 2022-02-18T17:55:36.2992752Z ::add-mask::*** 2022-02-18T17:55:36.2995698Z ::group::Setting up auth 2022-02-18T17:55:36.2996145Z ##[group]Setting up auth 2022-02-18T17:55:36.2996886Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand 2022-02-18T17:55:36.3035578Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || : 2022-02-18T17:55:36.3478141Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader 2022-02-18T17:55:36.3502857Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || : 2022-02-18T17:55:36.3795918Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic *** 2022-02-18T17:55:36.3852471Z ::endgroup:: 2022-02-18T17:55:36.3852907Z ##[endgroup] 2022-02-18T17:55:36.3853903Z ::group::Fetching the repository 2022-02-18T17:55:36.3854327Z ##[group]Fetching the repository 2022-02-18T17:55:36.3862122Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --progress --no-recurse-submodules --depth=1 origin +073497227b9162f7add1591442c0973a32c045e5:refs/remotes/origin/main 2022-02-18T17:55:36.5867261Z remote: Enumerating objects: 18, done. 2022-02-18T17:55:36.5868317Z remote: Counting objects: 5% (1/18) 2022-02-18T17:55:36.5869235Z remote: Counting objects: 11% (2/18) 2022-02-18T17:55:36.5870464Z remote: Counting objects: 16% (3/18) 2022-02-18T17:55:36.5872380Z remote: Counting objects: 22% (4/18) 2022-02-18T17:55:36.5874495Z remote: Counting objects: 27% (5/18) 2022-02-18T17:55:36.5875060Z remote: Counting objects: 33% (6/18) 2022-02-18T17:55:36.5875477Z remote: Counting objects: 38% (7/18) 2022-02-18T17:55:36.5876062Z remote: Counting objects: 44% (8/18) 2022-02-18T17:55:36.5938613Z remote: Counting objects: 50% (9/18) 2022-02-18T17:55:36.5939065Z remote: Counting objects: 55% (10/18) 2022-02-18T17:55:36.5941657Z remote: Counting objects: 61% (11/18) 2022-02-18T17:55:36.5943051Z remote: Counting objects: 66% (12/18) 2022-02-18T17:55:36.5944651Z remote: Counting objects: 72% (13/18) 2022-02-18T17:55:36.5945354Z remote: Counting objects: 77% (14/18) 2022-02-18T17:55:36.5945851Z remote: Counting objects: 83% (15/18) 2022-02-18T17:55:36.5946333Z remote: Counting objects: 88% (16/18) 2022-02-18T17:55:36.5946787Z remote: Counting objects: 94% (17/18) 2022-02-18T17:55:36.5947241Z remote: Counting objects: 100% (18/18) 2022-02-18T17:55:36.5948177Z remote: Counting objects: 100% (18/18), done. 2022-02-18T17:55:36.5948634Z remote: Compressing objects: 7% (1/14) 2022-02-18T17:55:36.5949070Z remote: Compressing objects: 14% (2/14) 2022-02-18T17:55:36.5949504Z remote: Compressing objects: 21% (3/14) 2022-02-18T17:55:36.5949932Z remote: Compressing objects: 28% (4/14) 2022-02-18T17:55:36.5950344Z remote: Compressing objects: 35% (5/14) 2022-02-18T17:55:36.5950768Z remote: Compressing objects: 42% (6/14) 2022-02-18T17:55:36.5951191Z remote: Compressing objects: 50% (7/14) 2022-02-18T17:55:36.5951633Z remote: Compressing objects: 57% (8/14) 2022-02-18T17:55:36.5952044Z remote: Compressing objects: 64% (9/14) 2022-02-18T17:55:36.5952475Z remote: Compressing objects: 71% (10/14) 2022-02-18T17:55:36.5952907Z remote: Compressing objects: 78% (11/14) 2022-02-18T17:55:36.5953338Z remote: Compressing objects: 85% (12/14) 2022-02-18T17:55:36.5953772Z remote: Compressing objects: 92% (13/14) 2022-02-18T17:55:36.5954188Z remote: Compressing objects: 100% (14/14) 2022-02-18T17:55:36.5954629Z remote: Compressing objects: 100% (14/14), done. 2022-02-18T17:55:36.5956165Z remote: Total 18 (delta 0), reused 13 (delta 0), pack-reused 0 2022-02-18T17:55:36.6059649Z From https://github.com/cds-snc/sre-test-repo 2022-02-18T17:55:36.6060350Z * [new ref] 073497227b9162f7add1591442c0973a32c045e5 -> origin/main 2022-02-18T17:55:36.6093413Z ::endgroup:: 2022-02-18T17:55:36.6093820Z ##[endgroup] 2022-02-18T17:55:36.6095490Z ::group::Determining the checkout info 2022-02-18T17:55:36.6095964Z ##[group]Determining the checkout info 2022-02-18T17:55:36.6097055Z ::endgroup:: 2022-02-18T17:55:36.6097424Z ##[endgroup] 2022-02-18T17:55:36.6098213Z ::group::Checking out the ref 2022-02-18T17:55:36.6098619Z ##[group]Checking out the ref 2022-02-18T17:55:36.6112713Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main 2022-02-18T17:55:36.6161463Z Switched to a new branch 'main' 2022-02-18T17:55:36.6182899Z branch 'main' set up to track 'origin/main'. 2022-02-18T17:55:36.6183742Z ::endgroup:: 2022-02-18T17:55:36.6184111Z ##[endgroup] 2022-02-18T17:55:36.6218886Z [command]/usr/bin/git log -1 --format='%H' 2022-02-18T17:55:36.6254551Z '073497227b9162f7add1591442c0973a32c045e5' 2022-02-18T17:55:36.6265400Z ::remove-matcher owner=checkout-git:: 2022-02-18T17:55:36.6295268Z ##[debug]Removed matchers: 'checkout-git' 2022-02-18T17:55:36.6363790Z ##[debug]Node Action run completed with exit code 0 2022-02-18T17:55:36.6420632Z ##[debug]Finishing: Run actions/checkout@v2 2022-02-18T17:55:36.6428046Z ##[debug]Evaluating condition for step: 'impersonate SRE Read/Write GH App' 2022-02-18T17:55:36.6430405Z ##[debug]Evaluating: success() 2022-02-18T17:55:36.6431130Z ##[debug]Evaluating success: 2022-02-18T17:55:36.6431747Z ##[debug]=> true 2022-02-18T17:55:36.6432420Z ##[debug]Result: true 2022-02-18T17:55:36.6433739Z ##[debug]Starting: impersonate SRE Read/Write GH App 2022-02-18T17:55:36.6458167Z ##[debug]Loading inputs 2022-02-18T17:55:36.6492258Z ##[debug]Evaluating: secrets.SRE_READWRITE_APP_ID 2022-02-18T17:55:36.6492717Z ##[debug]Evaluating Index: 2022-02-18T17:55:36.6493102Z ##[debug]..Evaluating secrets: 2022-02-18T17:55:36.6493506Z ##[debug]..=> Object 2022-02-18T17:55:36.6493876Z ##[debug]..Evaluating String: 2022-02-18T17:55:36.6494619Z ##[debug]..=> 'SRE_READWRITE_APP_ID' 2022-02-18T17:55:36.6496068Z ##[debug]=> '***' 2022-02-18T17:55:36.6496523Z ##[debug]Result: '***' 2022-02-18T17:55:36.6498206Z ##[debug]Evaluating: secrets.SRE_READWRITE_APP_PRIVATE_KEY 2022-02-18T17:55:36.6499212Z ##[debug]Evaluating Index: 2022-02-18T17:55:36.6499582Z ##[debug]..Evaluating secrets: 2022-02-18T17:55:36.6499962Z ##[debug]..=> Object 2022-02-18T17:55:36.6500329Z ##[debug]..Evaluating String: 2022-02-18T17:55:36.6500728Z ##[debug]..=> 'SRE_READWRITE_APP_PRIVATE_KEY' 2022-02-18T17:55:36.6501423Z ##[debug]=> '*** 2022-02-18T17:55:36.6501940Z ##[debug]*** 2022-02-18T17:55:36.6502427Z ##[debug]*** 2022-02-18T17:55:36.6502867Z ##[debug]*** 2022-02-18T17:55:36.6503336Z ##[debug]*** 2022-02-18T17:55:36.6503831Z ##[debug]*** 2022-02-18T17:55:36.6504292Z ##[debug]*** 2022-02-18T17:55:36.6504761Z ##[debug]*** 2022-02-18T17:55:36.6505404Z ##[debug]*** 2022-02-18T17:55:36.6506060Z ##[debug]*** 2022-02-18T17:55:36.6506555Z ##[debug]*** 2022-02-18T17:55:36.6507408Z ##[debug]*** 2022-02-18T17:55:36.6507942Z ##[debug]*** 2022-02-18T17:55:36.6508448Z ##[debug]*** 2022-02-18T17:55:36.6508979Z ##[debug]*** 2022-02-18T17:55:36.6509660Z ##[debug]*** 2022-02-18T17:55:36.6510155Z ##[debug]*** 2022-02-18T17:55:36.6510918Z ##[debug]*** 2022-02-18T17:55:36.6511355Z ##[debug]*** 2022-02-18T17:55:36.6512621Z ##[debug]*** 2022-02-18T17:55:36.6513247Z ##[debug]*** 2022-02-18T17:55:36.6513840Z ##[debug]*** 2022-02-18T17:55:36.6514447Z ##[debug]*** 2022-02-18T17:55:36.6515054Z ##[debug]*** 2022-02-18T17:55:36.6515736Z ##[debug]*** 2022-02-18T17:55:36.6516191Z ##[debug]*** 2022-02-18T17:55:36.6516576Z ##[debug]*** 2022-02-18T17:55:36.6516904Z ##[debug]' 2022-02-18T17:55:36.6518036Z ##[debug]Result: '*** 2022-02-18T17:55:36.6518943Z ##[debug]*** 2022-02-18T17:55:36.6519615Z ##[debug]*** 2022-02-18T17:55:36.6520253Z ##[debug]*** 2022-02-18T17:55:36.6520765Z ##[debug]*** 2022-02-18T17:55:36.6521704Z ##[debug]*** 2022-02-18T17:55:36.6522524Z ##[debug]*** 2022-02-18T17:55:36.6523030Z ##[debug]*** 2022-02-18T17:55:36.6523518Z ##[debug]*** 2022-02-18T17:55:36.6524006Z ##[debug]*** 2022-02-18T17:55:36.6524727Z ##[debug]*** 2022-02-18T17:55:36.6525395Z ##[debug]*** 2022-02-18T17:55:36.6526557Z ##[debug]*** 2022-02-18T17:55:36.6527218Z ##[debug]*** 2022-02-18T17:55:36.6527691Z ##[debug]*** 2022-02-18T17:55:36.6528206Z ##[debug]*** 2022-02-18T17:55:36.6528689Z ##[debug]*** 2022-02-18T17:55:36.6529155Z ##[debug]*** 2022-02-18T17:55:36.6529798Z ##[debug]*** 2022-02-18T17:55:36.6530334Z ##[debug]*** 2022-02-18T17:55:36.6531441Z ##[debug]*** 2022-02-18T17:55:36.6531941Z ##[debug]*** 2022-02-18T17:55:36.6532439Z ##[debug]*** 2022-02-18T17:55:36.6532942Z ##[debug]*** 2022-02-18T17:55:36.6533551Z ##[debug]*** 2022-02-18T17:55:36.6533991Z ##[debug]*** 2022-02-18T17:55:36.6534363Z ##[debug]*** 2022-02-18T17:55:36.6534688Z ##[debug]' 2022-02-18T17:55:36.6545041Z ##[debug]Loading env 2022-02-18T17:55:36.6553813Z ##[group]Run tibdex/github-app-token@7ce9ffd 2022-02-18T17:55:36.6554453Z with: 2022-02-18T17:55:36.6555002Z app_id: *** 2022-02-18T17:55:36.6559186Z private_key: ***

2022-02-18T17:55:36.6559653Z ##[endgroup]
2022-02-18T17:55:37.1793549Z ::add-mask::***
2022-02-18T17:55:37.1797493Z
2022-02-18T17:55:37.1801802Z ::set-output name=token::***
2022-02-18T17:55:37.1823264Z ##[debug]steps.generate_token.outputs.token=''
2022-02-18T17:55:37.1823783Z Token generated successfully!
2022-02-18T17:55:37.1877289Z ##[debug]Node Action run completed with exit code 0
2022-02-18T17:55:37.1879702Z ##[debug]Finishing: impersonate SRE Read/Write GH App
2022-02-18T17:55:37.1887005Z ##[debug]Evaluating condition for step: 'Sync SRE Workflows'
2022-02-18T17:55:37.1889411Z ##[debug]Evaluating: success()
2022-02-18T17:55:37.1890003Z ##[debug]Evaluating success:
2022-02-18T17:55:37.1890709Z ##[debug]=> true
2022-02-18T17:55:37.1891397Z ##[debug]Result: true
2022-02-18T17:55:37.1892604Z ##[debug]Starting: Sync SRE Workflows
2022-02-18T17:55:37.1928226Z ##[debug]Loading inputs
2022-02-18T17:55:37.1930624Z ##[debug]Evaluating: steps.generate_token.outputs.token
2022-02-18T17:55:37.1931921Z ##[debug]Evaluating Index:
2022-02-18T17:55:37.1932879Z ##[debug]..Evaluating Index:
2022-02-18T17:55:37.1933490Z ##[debug]....Evaluating Index:
2022-02-18T17:55:37.1934096Z ##[debug]......Evaluating steps:
2022-02-18T17:55:37.1934743Z ##[debug]......=> Object
2022-02-18T17:55:37.1935196Z ##[debug]......Evaluating String:
2022-02-18T17:55:37.1935660Z ##[debug]......=> 'generate_token'
2022-02-18T17:55:37.1936130Z ##[debug]....=> Object
2022-02-18T17:55:37.1936737Z ##[debug]....Evaluating String:
2022-02-18T17:55:37.1937551Z ##[debug]....=> 'outputs'
2022-02-18T17:55:37.1938114Z ##[debug]..=> Object
2022-02-18T17:55:37.1938508Z ##[debug]..Evaluating String:
2022-02-18T17:55:37.1938892Z ##[debug]..=> 'token'
2022-02-18T17:55:37.1939897Z ##[debug]=> '
'
2022-02-18T17:55:37.1940620Z ##[debug]Result: ''
2022-02-18T17:55:37.1950019Z ##[debug]Loading env
2022-02-18T17:55:37.1956294Z ##[group]Run 878d649
2022-02-18T17:55:37.1956782Z with:
2022-02-18T17:55:37.1957338Z GH_INSTALLATION_TOKEN: ***
2022-02-18T17:55:37.1957762Z CONFIG_PATH: tools/sre_file_sync/sync.yml
2022-02-18T17:55:37.1958184Z ASSIGNEES: CalvinRodo
2022-02-18T17:55:37.1958588Z GIT_EMAIL: sre-and-tech-ops@cds-snc.ca
2022-02-18T17:55:37.1958995Z GIT_USERNAME: CalvinRodo
2022-02-18T17:55:37.1959361Z ##[endgroup]
2022-02-18T17:55:37.2794846Z ::add-mask::

2022-02-18T17:55:37.2798362Z ##[debug]{
2022-02-18T17:55:37.2799036Z ##[debug] "GITHUB_TOKEN": "",
2022-02-18T17:55:37.2799461Z ##[debug] "IS_INSTALLATION_TOKEN": true,
2022-02-18T17:55:37.2799917Z ##[debug] "GIT_EMAIL": "sre-and-tech-ops@cds-snc.ca",
2022-02-18T17:55:37.2800365Z ##[debug] "GIT_USERNAME": "CalvinRodo",
2022-02-18T17:55:37.2800804Z ##[debug] "CONFIG_PATH": "tools/sre_file_sync/sync.yml",
2022-02-18T17:55:37.2801236Z ##[debug] "COMMIT_BODY": "",
2022-02-18T17:55:37.2801843Z ##[debug] "COMMIT_PREFIX": "🔄",
2022-02-18T17:55:37.2802246Z ##[debug] "COMMIT_EACH_FILE": true,
2022-02-18T17:55:37.2802636Z ##[debug] "PR_LABELS": [
2022-02-18T17:55:37.2803160Z ##[debug] "sync"
2022-02-18T17:55:37.2803737Z ##[debug] ],
2022-02-18T17:55:37.2804094Z ##[debug] "PR_BODY": "",
2022-02-18T17:55:37.2804455Z ##[debug] "ASSIGNEES": [
2022-02-18T17:55:37.2805003Z ##[debug] "CalvinRodo"
2022-02-18T17:55:37.2805351Z ##[debug] ],
2022-02-18T17:55:37.2805725Z ##[debug] "TMP_DIR": "tmp-1645206937277",
2022-02-18T17:55:37.2806118Z ##[debug] "DRY_RUN": false,
2022-02-18T17:55:37.2806505Z ##[debug] "SKIP_CLEANUP": false,
2022-02-18T17:55:37.2806899Z ##[debug] "OVERWRITE_EXISTING_PR": true,
2022-02-18T17:55:37.2807351Z ##[debug] "GITHUB_REPOSITORY": "cds-snc/sre-test-repo",
2022-02-18T17:55:37.2807785Z ##[debug] "SKIP_PR": false,
2022-02-18T17:55:37.2808161Z ##[debug] "ORIGINAL_MESSAGE": false,
2022-02-18T17:55:37.2808564Z ##[debug] "COMMIT_AS_PR_TITLE": false,
2022-02-18T17:55:37.2809010Z ##[debug] "BRANCH_PREFIX": "repo-sync/SOURCE_REPO_NAME",
2022-02-18T17:55:37.2809419Z ##[debug] "FORK": false
2022-02-18T17:55:37.2809765Z ##[debug]}
2022-02-18T17:55:37.2978638Z Repository Info
2022-02-18T17:55:37.2979554Z Slug : sre-test-repo
2022-02-18T17:55:37.2980757Z Owner : cds-snc
2022-02-18T17:55:37.2981595Z Https Url : https://github.com/cds-snc/sre-test-repo
2022-02-18T17:55:37.2982516Z Branch : default
2022-02-18T17:55:37.2983075Z
2022-02-18T17:55:37.2985683Z ##[debug]Cloning github.com/cds-snc/sre-test-repo into tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:37.2988475Z ##[debug]EXEC: "git clone --depth 1 github.com/cds-snc/sre-test-repo.git tmp-1645206937277/github.com/cds-snc/sre-test-repo@default" IN undefined
2022-02-18T17:55:37.5294528Z ##[debug]Setting git user to email: sre-and-tech-ops@cds-snc.ca, username: CalvinRodo
2022-02-18T17:55:37.5312687Z ##[debug]EXEC: "git config --local user.name "CalvinRodo" && git config --local user.email "sre-and-tech-ops@cds-snc.ca"" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:37.5373288Z ##[debug]EXEC: "git rev-parse --abbrev-ref HEAD" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:37.5425306Z ##[debug]EXEC: "git rev-parse HEAD" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:37.5466363Z ##[debug]Creating PR Branch repo-sync/sre-test-repo/default
2022-02-18T17:55:37.5468026Z ##[debug]EXEC: "git checkout -b "repo-sync/sre-test-repo/default"" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:37.7549829Z Found existing PR 3
2022-02-18T17:55:38.3347480Z Locally syncing file(s) between source and target repository
2022-02-18T17:55:38.3358322Z ##[debug]CP: tools/sre_file_sync/s3-backup.yml TO tmp-1645206937277/github.com/cds-snc/sre-test-repo@default/.github/workflows/s3-backup.yml
2022-02-18T17:55:38.3387462Z ##[debug]EXEC: "git add -f ".github/workflows/s3-backup.yml"" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3456844Z ##[debug]EXEC: "git status --porcelain" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3512718Z ##[debug]Creating commit for file(s) .github/workflows/s3-backup.yml
2022-02-18T17:55:38.3515011Z ##[debug]EXEC: "git commit -m '🔄 Created local '''.github/workflows/s3-backup.yml''' from remote '''tools/sre_file_sync/s3-backup.yml''''" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3601562Z ##[debug]EXEC: "git status --porcelain" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3655567Z Pushing changes to target repository
2022-02-18T17:55:38.3658912Z ##[debug]EXEC: "git log --format=%H --reverse main..HEAD" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3710570Z ##[debug]EXEC: "git log -1 --format=%B 6b1d64c0277e29ea7538de1c89751e9226fba6bc" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3758263Z ##[debug]EXEC: "git ls-tree -r --full-tree 6b1d64c0277e29ea7538de1c89751e9226fba6bc" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3804457Z ##[debug]EXEC: "git show e675925e0c21718ca7e4e28ab1a9549c8f4a8738" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3867717Z ##[debug]EXEC: "git show 18ff6cbfd01c79d6e8383d52fdd0648364026382" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3911248Z ##[debug]EXEC: "git show df6643fe376e42fab9a86d51ee86508faf2ee152" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.3969046Z ##[debug]EXEC: "git show 188ac134c7409f21478ae8a8e5625dd9a07b1e89" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4012277Z ##[debug]EXEC: "git show d2dec503be28fedb76c67f522c256a2038d34a35" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4056830Z ##[debug]EXEC: "git show 9240f7b4f28c4230cbdbc30f57ff7d30bb41ff48" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4101152Z ##[debug]EXEC: "git show a8a69f4c0bd864d71c538a0547b81adbdd4d9b83" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4144463Z ##[debug]EXEC: "git show 44263e81956ce2a591931fb4578abc6d480725cc" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4187837Z ##[debug]EXEC: "git show eabc54db263b548f9b10efaba051e4f03c8f8172" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4233899Z ##[debug]EXEC: "git show 17923302f7e71840a5c83cf0af735606bba9a29f" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4277217Z ##[debug]EXEC: "git show 18ff6cbfd01c79d6e8383d52fdd0648364026382" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.4319544Z ##[debug]EXEC: "git show 4a40e14d8074da8153523fb26ab64a5a1296c569" IN tmp-1645206937277/github.com/cds-snc/sre-test-repo@default
2022-02-18T17:55:38.9984082Z ##[debug]Creating a GitHub tree
2022-02-18T17:55:39.9719993Z ##[debug]Creating a commit for the GitHub tree
2022-02-18T17:55:41.0104228Z ##[debug]Updating branch repo-sync/sre-test-repo/default ref
2022-02-18T17:55:42.0228634Z ##[debug]Commit using GitHub API completed
2022-02-18T17:55:42.0236986Z Overwriting existing PR
2022-02-18T17:55:43.4578853Z ##[notice]Pull Request #3 created/updated: cds-snc/sre-test-repo#3
2022-02-18T17:55:43.4589913Z Adding label(s) "sync" to PR
2022-02-18T17:55:44.1000341Z Adding assignee(s) "CalvinRodo" to PR
2022-02-18T17:55:45.2028096Z
2022-02-18T17:55:45.2028775Z
2022-02-18T17:55:45.2030718Z ::set-output name=pull_request_urls::["https://github.com/cds-snc/sre-test-repo/pull/3"]
2022-02-18T17:55:45.2031688Z ##[debug]='["https://github.com/cds-snc/sre-test-repo/pull/3"]'
2022-02-18T17:55:45.2032745Z ##[debug]RM: tmp-1645206937277
2022-02-18T17:55:45.2164050Z Cleanup complete
2022-02-18T17:55:45.2225328Z ##[debug]Node Action run completed with exit code 0
2022-02-18T17:55:45.2228339Z ##[debug]Finishing: Sync SRE Workflows
2022-02-18T17:55:45.2233466Z ##[debug]Evaluating condition for step: 'Post Run actions/checkout@v2'
2022-02-18T17:55:45.2238215Z ##[debug]Evaluating: always()
2022-02-18T17:55:45.2348171Z ##[debug]Evaluating always:
2022-02-18T17:55:45.2349593Z ##[debug]=> true
2022-02-18T17:55:45.2350584Z ##[debug]Result: true
2022-02-18T17:55:45.2352323Z ##[debug]Starting: Post Run actions/checkout@v2
2022-02-18T17:55:45.2381694Z ##[debug]Loading inputs
2022-02-18T17:55:45.2383073Z ##[debug]Evaluating: github.repository
2022-02-18T17:55:45.2383561Z ##[debug]Evaluating Index:
2022-02-18T17:55:45.2383965Z ##[debug]..Evaluating github:
2022-02-18T17:55:45.2384752Z ##[debug]..=> Object
2022-02-18T17:55:45.2385362Z ##[debug]..Evaluating String:
2022-02-18T17:55:45.2385975Z ##[debug]..=> 'repository'
2022-02-18T17:55:45.2386475Z ##[debug]=> 'cds-snc/sre-test-repo'
2022-02-18T17:55:45.2386958Z ##[debug]Result: 'cds-snc/sre-test-repo'
2022-02-18T17:55:45.2389186Z ##[debug]Evaluating: github.token
2022-02-18T17:55:45.2389654Z ##[debug]Evaluating Index:
2022-02-18T17:55:45.2390050Z ##[debug]..Evaluating github:
2022-02-18T17:55:45.2390618Z ##[debug]..=> Object
2022-02-18T17:55:45.2391017Z ##[debug]..Evaluating String:
2022-02-18T17:55:45.2391388Z ##[debug]..=> 'token'
2022-02-18T17:55:45.2392225Z ##[debug]=> '
'
2022-02-18T17:55:45.2392776Z ##[debug]Result: '
'
2022-02-18T17:55:45.2400373Z ##[debug]Loading env
2022-02-18T17:55:45.2406208Z Post job cleanup.
2022-02-18T17:55:45.3819329Z ##[debug]Getting git version
2022-02-18T17:55:45.3843018Z [command]/usr/bin/git version
2022-02-18T17:55:45.3896767Z git version 2.35.1
2022-02-18T17:55:45.3926259Z ##[debug]Set git useragent to: git/2.35.1 (github-actions-checkout)
2022-02-18T17:55:45.3937903Z ::add-mask::***
2022-02-18T17:55:45.3950182Z [command]/usr/bin/git config --local --name-only --get-regexp core.sshCommand
2022-02-18T17:55:45.3991055Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'core.sshCommand' && git config --local --unset-all 'core.sshCommand' || :
2022-02-18T17:55:45.4270950Z [command]/usr/bin/git config --local --name-only --get-regexp http.https://github.com/.extraheader
2022-02-18T17:55:45.4301675Z http.https://github.com/.extraheader
2022-02-18T17:55:45.4326405Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader
2022-02-18T17:55:45.4374084Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'http.https://github.com/.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :
2022-02-18T17:55:45.4791521Z ##[debug]Node Action run completed with exit code 0
2022-02-18T17:55:45.4793533Z ##[debug]Finishing: Post Run actions/checkout@v2
2022-02-18T17:55:45.4956777Z ##[debug]Starting: Complete job
2022-02-18T17:55:45.4959001Z Cleaning up orphan processes
2022-02-18T17:55:45.5359562Z ##[debug]Finishing: Complete job
2022-02-18T17:55:45.5539264Z ##[debug]Finishing: sync_backup_workflow

</p>
</details>  

@BetaHuhn
Copy link
Owner

BetaHuhn commented Feb 18, 2022

Just tested with a PAT and it worked as expected so can confirm this is for using Installation Token auth only.

Thanks for testing! Would it be possible for you to use a PAT as a workaround for now?

The logs are from an action run that worked right? Could share the logs for a run that failed with the error from above as well?

@CalvinRodo
Copy link
Author

This is from a run that worked and submitted the binary, i'll run it with a larger file and append those.

Yes the plan is to use the PAT until there is a fix for the installation token auth as that's more sustainable for an org like mine where folks come and go.

@CalvinRodo
Copy link
Author

CalvinRodo commented Feb 18, 2022

logs for a failed run:

Debug logs...

``` 2022-02-18T18:17:28.5524334Z Requested labels: ubuntu-latest 2022-02-18T18:17:28.5524381Z Job defined at: cds-snc/sre-test-repo/.github/workflows/sre-file-sync.yml@refs/heads/main 2022-02-18T18:17:28.5524410Z Waiting for a runner to pick up this job... 2022-02-18T18:17:28.9876927Z Job is waiting for a hosted runner to come online. 2022-02-18T18:17:33.1362651Z Job is about to start running on the hosted runner: Hosted Agent (hosted) 2022-02-18T18:17:36.1363309Z ##[debug]Starting: sync_backup_workflow 2022-02-18T18:17:36.1394478Z ##[debug]Cleaning runner temp folder: /home/runner/work/_temp 2022-02-18T18:17:36.1725900Z ##[debug]Starting: Set up job 2022-02-18T18:17:36.1726714Z Current runner version: '2.287.1' 2022-02-18T18:17:36.1753527Z ##[group]Operating System 2022-02-18T18:17:36.1754515Z Ubuntu 2022-02-18T18:17:36.1755136Z 20.04.3 2022-02-18T18:17:36.1755752Z LTS 2022-02-18T18:17:36.1756377Z ##[endgroup] 2022-02-18T18:17:36.1757102Z ##[group]Virtual Environment 2022-02-18T18:17:36.1757842Z Environment: ubuntu-20.04 2022-02-18T18:17:36.1758567Z Version: 20220213.1 2022-02-18T18:17:36.1759505Z Included Software: https://github.com/actions/virtual-environments/blob/ubuntu20/20220213.1/images/linux/Ubuntu2004-Readme.md 2022-02-18T18:17:36.1760781Z Image Release: https://github.com/actions/virtual-environments/releases/tag/ubuntu20%2F20220213.1 2022-02-18T18:17:36.1762022Z ##[endgroup] 2022-02-18T18:17:36.1762800Z ##[group]Virtual Environment Provisioner 2022-02-18T18:17:36.1763713Z 1.0.0.0-main-20220202-1 2022-02-18T18:17:36.1764427Z ##[endgroup] 2022-02-18T18:17:36.1766224Z ##[group]GITHUB_TOKEN Permissions 2022-02-18T18:17:36.1767271Z Actions: write 2022-02-18T18:17:36.1767943Z Checks: write 2022-02-18T18:17:36.1768612Z Contents: write 2022-02-18T18:17:36.1769301Z Deployments: write 2022-02-18T18:17:36.1770012Z Discussions: write 2022-02-18T18:17:36.1770682Z Issues: write 2022-02-18T18:17:36.1771318Z Metadata: read 2022-02-18T18:17:36.1771995Z Packages: write 2022-02-18T18:17:36.1772687Z Pages: write 2022-02-18T18:17:36.1773366Z PullRequests: write 2022-02-18T18:17:36.1774164Z RepositoryProjects: write 2022-02-18T18:17:36.1774889Z SecurityEvents: write 2022-02-18T18:17:36.1775593Z Statuses: write 2022-02-18T18:17:36.1776264Z ##[endgroup] 2022-02-18T18:17:36.1781335Z Secret source: Actions 2022-02-18T18:17:36.1782224Z ##[debug]Primary repository: cds-snc/sre-test-repo 2022-02-18T18:17:36.1783060Z Prepare workflow directory 2022-02-18T18:17:36.1875573Z ##[debug]Creating pipeline directory: '/home/runner/work/sre-test-repo' 2022-02-18T18:17:36.1879442Z ##[debug]Creating workspace directory: '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T18:17:36.1881104Z ##[debug]Update context data 2022-02-18T18:17:36.1885006Z ##[debug]Evaluating job-level environment variables 2022-02-18T18:17:36.2749838Z ##[debug]Evaluating job container 2022-02-18T18:17:36.2757115Z ##[debug]Evaluating job service containers 2022-02-18T18:17:36.2760544Z ##[debug]Evaluating job defaults 2022-02-18T18:17:36.2852644Z Prepare all required actions 2022-02-18T18:17:36.3102203Z Getting action download info 2022-02-18T18:17:36.5308915Z Download action repository 'actions/checkout@v2' (SHA:ec3a7ce113134d7a93b817d10a8272cb61118579) 2022-02-18T18:17:36.7020657Z ##[debug]Download 'https://api.github.com/repos/actions/checkout/tarball/ec3a7ce113134d7a93b817d10a8272cb61118579' to '/home/runner/work/_actions/_temp_949282c9-1da5-4d68-a930-531891736758/9637b4ee-936c-4f2e-a242-a7467e82c7e9.tar.gz' 2022-02-18T18:17:36.8415987Z ##[debug]Unwrap 'actions-checkout-ec3a7ce' to '/home/runner/work/_actions/actions/checkout/v2' 2022-02-18T18:17:36.8589570Z ##[debug]Archive '/home/runner/work/_actions/_temp_949282c9-1da5-4d68-a930-531891736758/9637b4ee-936c-4f2e-a242-a7467e82c7e9.tar.gz' has been unzipped into '/home/runner/work/_actions/actions/checkout/v2'. 2022-02-18T18:17:36.8754001Z Download action repository 'tibdex/github-app-token@7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' (SHA:7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4) 2022-02-18T18:17:37.0050181Z ##[debug]Download 'https://api.github.com/repos/tibdex/github-app-token/tarball/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' to '/home/runner/work/_actions/_temp_ab0d639b-ef36-4ce6-aaeb-c01d4fc0a1f7/6f6986da-cbb4-465b-9878-347564ff1fce.tar.gz' 2022-02-18T18:17:37.0215130Z ##[debug]Unwrap 'tibdex-github-app-token-7ce9ffd' to '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4' 2022-02-18T18:17:37.0229308Z ##[debug]Archive '/home/runner/work/_actions/_temp_ab0d639b-ef36-4ce6-aaeb-c01d4fc0a1f7/6f6986da-cbb4-465b-9878-347564ff1fce.tar.gz' has been unzipped into '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4'. 2022-02-18T18:17:37.0248363Z Download action repository 'BetaHuhn/repo-file-sync-action@878d649' (SHA:878d649c33c834dc1eff4c00f7fcf16bf281eb63) 2022-02-18T18:17:37.6776346Z ##[debug]Download 'https://api.github.com/repos/BetaHuhn/repo-file-sync-action/tarball/878d649c33c834dc1eff4c00f7fcf16bf281eb63' to '/home/runner/work/_actions/_temp_dfcc8df3-fa26-4477-b297-188f2410d2a5/3d42b43d-f663-4c8d-b691-2ad5363c4923.tar.gz' 2022-02-18T18:17:37.6948277Z ##[debug]Unwrap 'BetaHuhn-repo-file-sync-action-878d649' to '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63' 2022-02-18T18:17:37.6979229Z ##[debug]Archive '/home/runner/work/_actions/_temp_dfcc8df3-fa26-4477-b297-188f2410d2a5/3d42b43d-f663-4c8d-b691-2ad5363c4923.tar.gz' has been unzipped into '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63'. 2022-02-18T18:17:37.7054272Z ##[debug]action.yml for action: '/home/runner/work/_actions/actions/checkout/v2/action.yml'. 2022-02-18T18:17:37.8127855Z ##[debug]action.yml for action: '/home/runner/work/_actions/tibdex/github-app-token/7ce9ffdcdeb2ba82b01b51d6584a6a85872336d4/action.yml'. 2022-02-18T18:17:37.8153340Z ##[debug]action.yml for action: '/home/runner/work/_actions/BetaHuhn/repo-file-sync-action/878d649c33c834dc1eff4c00f7fcf16bf281eb63/action.yml'. 2022-02-18T18:17:37.8379011Z ##[debug]Set step '__actions_checkout' display name to: 'Run actions/checkout@v2' 2022-02-18T18:17:37.8382774Z ##[debug]Set step 'generate_token' display name to: 'impersonate SRE Read/Write GH App' 2022-02-18T18:17:37.8384547Z ##[debug]Set step '__BetaHuhn_repo-file-sync-action' display name to: 'Sync SRE Workflows' 2022-02-18T18:17:37.8396657Z ##[debug]Collect running processes for tracking orphan processes. 2022-02-18T18:17:37.8661499Z ##[debug]Finishing: Set up job 2022-02-18T18:17:37.8837768Z ##[debug]Evaluating condition for step: 'Run actions/checkout@v2' 2022-02-18T18:17:37.8907517Z ##[debug]Evaluating: success() 2022-02-18T18:17:37.8915244Z ##[debug]Evaluating success: 2022-02-18T18:17:37.8948185Z ##[debug]=> true 2022-02-18T18:17:37.8957192Z ##[debug]Result: true 2022-02-18T18:17:37.9009540Z ##[debug]Starting: Run actions/checkout@v2 2022-02-18T18:17:37.9145848Z ##[debug]Register post job cleanup for action: actions/checkout@v2 2022-02-18T18:17:37.9268205Z ##[debug]Loading inputs 2022-02-18T18:17:37.9279005Z ##[debug]Evaluating: github.repository 2022-02-18T18:17:37.9280309Z ##[debug]Evaluating Index: 2022-02-18T18:17:37.9283284Z ##[debug]..Evaluating github: 2022-02-18T18:17:37.9284690Z ##[debug]..=> Object 2022-02-18T18:17:37.9301278Z ##[debug]..Evaluating String: 2022-02-18T18:17:37.9302281Z ##[debug]..=> 'repository' 2022-02-18T18:17:37.9307633Z ##[debug]=> 'cds-snc/sre-test-repo' 2022-02-18T18:17:37.9310037Z ##[debug]Result: 'cds-snc/sre-test-repo' 2022-02-18T18:17:37.9313270Z ##[debug]Evaluating: github.token 2022-02-18T18:17:37.9313785Z ##[debug]Evaluating Index: 2022-02-18T18:17:37.9314254Z ##[debug]..Evaluating github: 2022-02-18T18:17:37.9314733Z ##[debug]..=> Object 2022-02-18T18:17:37.9315198Z ##[debug]..Evaluating String: 2022-02-18T18:17:37.9315648Z ##[debug]..=> 'token' 2022-02-18T18:17:37.9316596Z ##[debug]=> '***' 2022-02-18T18:17:37.9317205Z ##[debug]Result: '***' 2022-02-18T18:17:37.9324438Z ##[debug]Loading env 2022-02-18T18:17:37.9432297Z ##[group]Run actions/checkout@v2 2022-02-18T18:17:37.9432783Z with: 2022-02-18T18:17:37.9433241Z repository: cds-snc/sre-test-repo 2022-02-18T18:17:37.9434035Z token: *** 2022-02-18T18:17:37.9434459Z ssh-strict: true 2022-02-18T18:17:37.9434915Z persist-credentials: true 2022-02-18T18:17:37.9435344Z clean: true 2022-02-18T18:17:37.9435833Z fetch-depth: 1 2022-02-18T18:17:37.9436246Z lfs: false 2022-02-18T18:17:37.9436662Z submodules: false 2022-02-18T18:17:37.9437360Z ##[endgroup] 2022-02-18T18:17:38.1825032Z ::save-state name=isPost::true 2022-02-18T18:17:38.1829772Z ##[debug]Save intra-action state isPost = true 2022-02-18T18:17:38.2300407Z ##[debug]GITHUB_WORKSPACE = '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T18:17:38.2315475Z ##[debug]qualified repository = 'cds-snc/sre-test-repo' 2022-02-18T18:17:38.2317648Z ##[debug]ref = 'refs/heads/main' 2022-02-18T18:17:38.2319674Z ##[debug]commit = '8731ffedf799cc405f5161a0dfc51828a5048c62' 2022-02-18T18:17:38.2321666Z ##[debug]clean = true 2022-02-18T18:17:38.2322981Z ##[debug]fetch depth = 1 2022-02-18T18:17:38.2324115Z ##[debug]lfs = false 2022-02-18T18:17:38.2327159Z ##[debug]submodules = false 2022-02-18T18:17:38.2328170Z ##[debug]recursive submodules = false 2022-02-18T18:17:38.2435505Z ::add-matcher::/home/runner/work/_actions/actions/checkout/v2/dist/problem-matcher.json 2022-02-18T18:17:38.2576645Z ##[debug]Added matchers: 'checkout-git'. Problem matchers scan action output for known warning or error strings and report these inline. 2022-02-18T18:17:38.2588377Z Syncing repository: cds-snc/sre-test-repo 2022-02-18T18:17:38.2589888Z ::group::Getting Git version info 2022-02-18T18:17:38.2591441Z ##[group]Getting Git version info 2022-02-18T18:17:38.2592257Z Working directory is '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T18:17:38.2593222Z ##[debug]Getting git version 2022-02-18T18:17:38.2593691Z [command]/usr/bin/git version 2022-02-18T18:17:38.2683817Z git version 2.35.1 2022-02-18T18:17:38.2698631Z ##[debug]Set git useragent to: git/2.35.1 (github-actions-checkout) 2022-02-18T18:17:38.2699937Z ::endgroup:: 2022-02-18T18:17:38.2700596Z ##[endgroup] 2022-02-18T18:17:38.2706551Z Deleting the contents of '/home/runner/work/sre-test-repo/sre-test-repo' 2022-02-18T18:17:38.2711786Z ::save-state name=repositoryPath::/home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T18:17:38.2712880Z ##[debug]Save intra-action state repositoryPath = /home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T18:17:38.2714445Z ::group::Initializing the repository 2022-02-18T18:17:38.2716431Z ##[group]Initializing the repository 2022-02-18T18:17:38.2717391Z [command]/usr/bin/git init /home/runner/work/sre-test-repo/sre-test-repo 2022-02-18T18:17:38.2800293Z hint: Using 'master' as the name for the initial branch. This default branch name 2022-02-18T18:17:38.2801158Z hint: is subject to change. To configure the initial branch name to use in all 2022-02-18T18:17:38.2802243Z hint: of your new repositories, which will suppress this warning, call: 2022-02-18T18:17:38.2802943Z hint: 2022-02-18T18:17:38.2803768Z hint: git config --global init.defaultBranch 2022-02-18T18:17:38.2804377Z hint: 2022-02-18T18:17:38.2805168Z hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and 2022-02-18T18:17:38.2806140Z hint: 'development'. The just-created branch can be renamed via this command: 2022-02-18T18:17:38.2806849Z hint: 2022-02-18T18:17:38.2807531Z hint: git branch -m 2022-02-18T18:17:38.2817780Z Initialized empty Git repository in /home/runner/work/sre-test-repo/sre-test-repo/.git/ 2022-02-18T18:17:38.2832390Z [command]/usr/bin/git remote add origin https://github.com/cds-snc/sre-test-repo 2022-02-18T18:17:38.2881065Z ::endgroup:: 2022-02-18T18:17:38.2881943Z ##[endgroup] 2022-02-18T18:17:38.2883498Z ::group::Disabling automatic garbage collection 2022-02-18T18:17:38.2884212Z ##[group]Disabling automatic garbage collection 2022-02-18T18:17:38.2887195Z [command]/usr/bin/git config --local gc.auto 0 2022-02-18T18:17:38.2931584Z ::endgroup:: 2022-02-18T18:17:38.2932169Z ##[endgroup] 2022-02-18T18:17:38.2951467Z ::add-mask::*** 2022-02-18T18:17:38.2954077Z ::group::Setting up auth 2022-02-18T18:17:38.2954725Z ##[group]Setting up auth 2022-02-18T18:17:38.2956032Z [command]/usr/bin/git config --local --name-only --get-regexp core\.sshCommand 2022-02-18T18:17:38.2989240Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'core\.sshCommand' && git config --local --unset-all 'core.sshCommand' || : 2022-02-18T18:17:38.3398376Z [command]/usr/bin/git config --local --name-only --get-regexp http\.https\:\/\/github\.com\/\.extraheader 2022-02-18T18:17:38.3438330Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'http\.https\:\/\/github\.com\/\.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || : 2022-02-18T18:17:38.3810745Z [command]/usr/bin/git config --local http.https://github.com/.extraheader AUTHORIZATION: basic *** 2022-02-18T18:17:38.3862538Z ::endgroup:: 2022-02-18T18:17:38.3863616Z ##[endgroup] 2022-02-18T18:17:38.3864619Z ::group::Fetching the repository 2022-02-18T18:17:38.3865300Z ##[group]Fetching the repository 2022-02-18T18:17:38.3872380Z [command]/usr/bin/git -c protocol.version=2 fetch --no-tags --prune --progress --no-recurse-submodules --depth=1 origin +8731ffedf799cc405f5161a0dfc51828a5048c62:refs/remotes/origin/main 2022-02-18T18:17:38.5984584Z remote: Enumerating objects: 19, done. 2022-02-18T18:17:38.5986325Z remote: Counting objects: 5% (1/19) 2022-02-18T18:17:38.5987115Z remote: Counting objects: 10% (2/19) 2022-02-18T18:17:38.5987984Z remote: Counting objects: 15% (3/19) 2022-02-18T18:17:38.5988736Z remote: Counting objects: 21% (4/19) 2022-02-18T18:17:38.5989484Z remote: Counting objects: 26% (5/19) 2022-02-18T18:17:38.5990156Z remote: Counting objects: 31% (6/19) 2022-02-18T18:17:38.5990907Z remote: Counting objects: 36% (7/19) 2022-02-18T18:17:38.5991697Z remote: Counting objects: 42% (8/19) 2022-02-18T18:17:38.5992450Z remote: Counting objects: 47% (9/19) 2022-02-18T18:17:38.5993178Z remote: Counting objects: 52% (10/19) 2022-02-18T18:17:38.5993885Z remote: Counting objects: 57% (11/19) 2022-02-18T18:17:38.5994627Z remote: Counting objects: 63% (12/19) 2022-02-18T18:17:38.5995403Z remote: Counting objects: 68% (13/19) 2022-02-18T18:17:38.5996437Z remote: Counting objects: 73% (14/19) 2022-02-18T18:17:38.5997156Z remote: Counting objects: 78% (15/19) 2022-02-18T18:17:38.5997905Z remote: Counting objects: 84% (16/19) 2022-02-18T18:17:38.5998667Z remote: Counting objects: 89% (17/19) 2022-02-18T18:17:38.5999399Z remote: Counting objects: 94% (18/19) 2022-02-18T18:17:38.6000161Z remote: Counting objects: 100% (19/19) 2022-02-18T18:17:38.6000858Z remote: Counting objects: 100% (19/19), done. 2022-02-18T18:17:38.6001902Z remote: Compressing objects: 6% (1/15) 2022-02-18T18:17:38.6002732Z remote: Compressing objects: 13% (2/15) 2022-02-18T18:17:38.6003491Z remote: Compressing objects: 20% (3/15) 2022-02-18T18:17:38.6004216Z remote: Compressing objects: 26% (4/15) 2022-02-18T18:17:38.6004981Z remote: Compressing objects: 33% (5/15) 2022-02-18T18:17:38.6005772Z remote: Compressing objects: 40% (6/15) 2022-02-18T18:17:38.6006545Z remote: Compressing objects: 46% (7/15) 2022-02-18T18:17:38.6007323Z remote: Compressing objects: 53% (8/15) 2022-02-18T18:17:38.6008042Z remote: Compressing objects: 60% (9/15) 2022-02-18T18:17:38.6008848Z remote: Compressing objects: 66% (10/15) 2022-02-18T18:17:38.6009640Z remote: Compressing objects: 73% (11/15) 2022-02-18T18:17:38.6010445Z remote: Compressing objects: 80% (12/15) 2022-02-18T18:17:38.6011222Z remote: Compressing objects: 86% (13/15) 2022-02-18T18:17:38.6011954Z remote: Compressing objects: 93% (14/15) 2022-02-18T18:17:38.6012727Z remote: Compressing objects: 100% (15/15) 2022-02-18T18:17:38.6013586Z remote: Compressing objects: 100% (15/15), done. 2022-02-18T18:17:38.6388619Z remote: Total 19 (delta 0), reused 14 (delta 0), pack-reused 0 2022-02-18T18:17:38.6917449Z From https://github.com/cds-snc/sre-test-repo 2022-02-18T18:17:38.6919008Z * [new ref] 8731ffedf799cc405f5161a0dfc51828a5048c62 -> origin/main 2022-02-18T18:17:38.6956716Z ::endgroup:: 2022-02-18T18:17:38.6957595Z ##[endgroup] 2022-02-18T18:17:38.6959957Z ::group::Determining the checkout info 2022-02-18T18:17:38.6960894Z ##[group]Determining the checkout info 2022-02-18T18:17:38.6963713Z ::endgroup:: 2022-02-18T18:17:38.6964584Z ##[endgroup] 2022-02-18T18:17:38.6966359Z ::group::Checking out the ref 2022-02-18T18:17:38.6967485Z ##[group]Checking out the ref 2022-02-18T18:17:38.6969985Z [command]/usr/bin/git checkout --progress --force -B main refs/remotes/origin/main 2022-02-18T18:17:38.7057894Z Switched to a new branch 'main' 2022-02-18T18:17:38.7063890Z branch 'main' set up to track 'origin/main'. 2022-02-18T18:17:38.7068353Z ::endgroup:: 2022-02-18T18:17:38.7068997Z ##[endgroup] 2022-02-18T18:17:38.7118411Z [command]/usr/bin/git log -1 --format='%H' 2022-02-18T18:17:38.7152955Z '8731ffedf799cc405f5161a0dfc51828a5048c62' 2022-02-18T18:17:38.7165289Z ::remove-matcher owner=checkout-git:: 2022-02-18T18:17:38.7195262Z ##[debug]Removed matchers: 'checkout-git' 2022-02-18T18:17:38.7220555Z ##[debug]Node Action run completed with exit code 0 2022-02-18T18:17:38.7394634Z ##[debug]Finishing: Run actions/checkout@v2 2022-02-18T18:17:38.7405501Z ##[debug]Evaluating condition for step: 'impersonate SRE Read/Write GH App' 2022-02-18T18:17:38.7408421Z ##[debug]Evaluating: success() 2022-02-18T18:17:38.7409085Z ##[debug]Evaluating success: 2022-02-18T18:17:38.7409931Z ##[debug]=> true 2022-02-18T18:17:38.7410691Z ##[debug]Result: true 2022-02-18T18:17:38.7411895Z ##[debug]Starting: impersonate SRE Read/Write GH App 2022-02-18T18:17:38.7436982Z ##[debug]Loading inputs 2022-02-18T18:17:38.7473840Z ##[debug]Evaluating: secrets.SRE_READWRITE_APP_ID 2022-02-18T18:17:38.7474446Z ##[debug]Evaluating Index: 2022-02-18T18:17:38.7474923Z ##[debug]..Evaluating secrets: 2022-02-18T18:17:38.7475408Z ##[debug]..=> Object 2022-02-18T18:17:38.7475879Z ##[debug]..Evaluating String: 2022-02-18T18:17:38.7476348Z ##[debug]..=> 'SRE_READWRITE_APP_ID' 2022-02-18T18:17:38.7477136Z ##[debug]=> '***' 2022-02-18T18:17:38.7477623Z ##[debug]Result: '***' 2022-02-18T18:17:38.7479151Z ##[debug]Evaluating: secrets.SRE_READWRITE_APP_PRIVATE_KEY 2022-02-18T18:17:38.7479765Z ##[debug]Evaluating Index: 2022-02-18T18:17:38.7480222Z ##[debug]..Evaluating secrets: 2022-02-18T18:17:38.7480690Z ##[debug]..=> Object 2022-02-18T18:17:38.7481153Z ##[debug]..Evaluating String: 2022-02-18T18:17:38.7481892Z ##[debug]..=> 'SRE_READWRITE_APP_PRIVATE_KEY' 2022-02-18T18:17:38.7482656Z ##[debug]=> '*** 2022-02-18T18:17:38.7483310Z ##[debug]*** 2022-02-18T18:17:38.7483941Z ##[debug]*** 2022-02-18T18:17:38.7484524Z ##[debug]*** 2022-02-18T18:17:38.7485114Z ##[debug]*** 2022-02-18T18:17:38.7485752Z ##[debug]*** 2022-02-18T18:17:38.7486339Z ##[debug]*** 2022-02-18T18:17:38.7486947Z ##[debug]*** 2022-02-18T18:17:38.7487520Z ##[debug]*** 2022-02-18T18:17:38.7488092Z ##[debug]*** 2022-02-18T18:17:38.7488699Z ##[debug]*** 2022-02-18T18:17:38.7489242Z ##[debug]*** 2022-02-18T18:17:38.7489875Z ##[debug]*** 2022-02-18T18:17:38.7490510Z ##[debug]*** 2022-02-18T18:17:38.7491070Z ##[debug]*** 2022-02-18T18:17:38.7491687Z ##[debug]*** 2022-02-18T18:17:38.7492256Z ##[debug]*** 2022-02-18T18:17:38.7492831Z ##[debug]*** 2022-02-18T18:17:38.7493367Z ##[debug]*** 2022-02-18T18:17:38.7493994Z ##[debug]*** 2022-02-18T18:17:38.7494571Z ##[debug]*** 2022-02-18T18:17:38.7495142Z ##[debug]*** 2022-02-18T18:17:38.7495760Z ##[debug]*** 2022-02-18T18:17:38.7496377Z ##[debug]*** 2022-02-18T18:17:38.7496950Z ##[debug]*** 2022-02-18T18:17:38.7497479Z ##[debug]*** 2022-02-18T18:17:38.7497940Z ##[debug]*** 2022-02-18T18:17:38.7498334Z ##[debug]' 2022-02-18T18:17:38.7498957Z ##[debug]Result: '*** 2022-02-18T18:17:38.7499608Z ##[debug]*** 2022-02-18T18:17:38.7500227Z ##[debug]*** 2022-02-18T18:17:38.7500798Z ##[debug]*** 2022-02-18T18:17:38.7501384Z ##[debug]*** 2022-02-18T18:17:38.7502009Z ##[debug]*** 2022-02-18T18:17:38.7502596Z ##[debug]*** 2022-02-18T18:17:38.7503196Z ##[debug]*** 2022-02-18T18:17:38.7504100Z ##[debug]*** 2022-02-18T18:17:38.7504682Z ##[debug]*** 2022-02-18T18:17:38.7505299Z ##[debug]*** 2022-02-18T18:17:38.7505851Z ##[debug]*** 2022-02-18T18:17:38.7506467Z ##[debug]*** 2022-02-18T18:17:38.7507049Z ##[debug]*** 2022-02-18T18:17:38.7507605Z ##[debug]*** 2022-02-18T18:17:38.7508221Z ##[debug]*** 2022-02-18T18:17:38.7508790Z ##[debug]*** 2022-02-18T18:17:38.7509347Z ##[debug]*** 2022-02-18T18:17:38.7509880Z ##[debug]*** 2022-02-18T18:17:38.7510505Z ##[debug]*** 2022-02-18T18:17:38.7511072Z ##[debug]*** 2022-02-18T18:17:38.7511647Z ##[debug]*** 2022-02-18T18:17:38.7512257Z ##[debug]*** 2022-02-18T18:17:38.7512965Z ##[debug]*** 2022-02-18T18:17:38.7513534Z ##[debug]*** 2022-02-18T18:17:38.7514072Z ##[debug]*** 2022-02-18T18:17:38.7514528Z ##[debug]*** 2022-02-18T18:17:38.7514920Z ##[debug]' 2022-02-18T18:17:38.7527453Z ##[debug]Loading env 2022-02-18T18:17:38.7534944Z ##[group]Run tibdex/github-app-token@7ce9ffd 2022-02-18T18:17:38.7535514Z with: 2022-02-18T18:17:38.7536019Z app_id: *** 2022-02-18T18:17:38.7541878Z private_key: ***

2022-02-18T18:17:38.7542316Z ##[endgroup]
2022-02-18T18:17:39.2093534Z ::add-mask::***
2022-02-18T18:17:39.2131388Z
2022-02-18T18:17:39.2134726Z ::set-output name=token::***
2022-02-18T18:17:39.2165191Z ##[debug]steps.generate_token.outputs.token=''
2022-02-18T18:17:39.2165990Z Token generated successfully!
2022-02-18T18:17:39.2196084Z ##[debug]Node Action run completed with exit code 0
2022-02-18T18:17:39.2198336Z ##[debug]Finishing: impersonate SRE Read/Write GH App
2022-02-18T18:17:39.2205987Z ##[debug]Evaluating condition for step: 'Sync SRE Workflows'
2022-02-18T18:17:39.2208482Z ##[debug]Evaluating: success()
2022-02-18T18:17:39.2209489Z ##[debug]Evaluating success:
2022-02-18T18:17:39.2210249Z ##[debug]=> true
2022-02-18T18:17:39.2210988Z ##[debug]Result: true
2022-02-18T18:17:39.2211938Z ##[debug]Starting: Sync SRE Workflows
2022-02-18T18:17:39.2249476Z ##[debug]Loading inputs
2022-02-18T18:17:39.2250965Z ##[debug]Evaluating: steps.generate_token.outputs.token
2022-02-18T18:17:39.2251541Z ##[debug]Evaluating Index:
2022-02-18T18:17:39.2252022Z ##[debug]..Evaluating Index:
2022-02-18T18:17:39.2252491Z ##[debug]....Evaluating Index:
2022-02-18T18:17:39.2252966Z ##[debug]......Evaluating steps:
2022-02-18T18:17:39.2253458Z ##[debug]......=> Object
2022-02-18T18:17:39.2253946Z ##[debug]......Evaluating String:
2022-02-18T18:17:39.2254444Z ##[debug]......=> 'generate_token'
2022-02-18T18:17:39.2254956Z ##[debug]....=> Object
2022-02-18T18:17:39.2255455Z ##[debug]....Evaluating String:
2022-02-18T18:17:39.2255926Z ##[debug]....=> 'outputs'
2022-02-18T18:17:39.2256379Z ##[debug]..=> Object
2022-02-18T18:17:39.2256847Z ##[debug]..Evaluating String:
2022-02-18T18:17:39.2257304Z ##[debug]..=> 'token'
2022-02-18T18:17:39.2258093Z ##[debug]=> '
'
2022-02-18T18:17:39.2258722Z ##[debug]Result: ''
2022-02-18T18:17:39.2267855Z ##[debug]Loading env
2022-02-18T18:17:39.2274562Z ##[group]Run 878d649
2022-02-18T18:17:39.2275154Z with:
2022-02-18T18:17:39.2276095Z GH_INSTALLATION_TOKEN: ***
2022-02-18T18:17:39.2276607Z CONFIG_PATH: tools/sre_file_sync/sync.yml
2022-02-18T18:17:39.2277107Z ASSIGNEES: CalvinRodo
2022-02-18T18:17:39.2277602Z GIT_EMAIL: sre-and-tech-ops@cds-snc.ca
2022-02-18T18:17:39.2278102Z GIT_USERNAME: CalvinRodo
2022-02-18T18:17:39.2278546Z ##[endgroup]
2022-02-18T18:17:39.3182974Z ::add-mask::

2022-02-18T18:17:39.3184768Z ##[debug]{
2022-02-18T18:17:39.3185581Z ##[debug] "GITHUB_TOKEN": "",
2022-02-18T18:17:39.3186093Z ##[debug] "IS_INSTALLATION_TOKEN": true,
2022-02-18T18:17:39.3186640Z ##[debug] "GIT_EMAIL": "sre-and-tech-ops@cds-snc.ca",
2022-02-18T18:17:39.3187198Z ##[debug] "GIT_USERNAME": "CalvinRodo",
2022-02-18T18:17:39.3187749Z ##[debug] "CONFIG_PATH": "tools/sre_file_sync/sync.yml",
2022-02-18T18:17:39.3188278Z ##[debug] "COMMIT_BODY": "",
2022-02-18T18:17:39.3189039Z ##[debug] "COMMIT_PREFIX": "🔄",
2022-02-18T18:17:39.3189523Z ##[debug] "COMMIT_EACH_FILE": true,
2022-02-18T18:17:39.3190193Z ##[debug] "PR_LABELS": [
2022-02-18T18:17:39.3190627Z ##[debug] "sync"
2022-02-18T18:17:39.3191037Z ##[debug] ],
2022-02-18T18:17:39.3191461Z ##[debug] "PR_BODY": "",
2022-02-18T18:17:39.3191901Z ##[debug] "ASSIGNEES": [
2022-02-18T18:17:39.3192337Z ##[debug] "CalvinRodo"
2022-02-18T18:17:39.3192738Z ##[debug] ],
2022-02-18T18:17:39.3193198Z ##[debug] "TMP_DIR": "tmp-1645208259312",
2022-02-18T18:17:39.3193676Z ##[debug] "DRY_RUN": false,
2022-02-18T18:17:39.3194143Z ##[debug] "SKIP_CLEANUP": false,
2022-02-18T18:17:39.3194639Z ##[debug] "OVERWRITE_EXISTING_PR": true,
2022-02-18T18:17:39.3195214Z ##[debug] "GITHUB_REPOSITORY": "cds-snc/sre-test-repo",
2022-02-18T18:17:39.3197710Z ##[debug] "SKIP_PR": false,
2022-02-18T18:17:39.3198198Z ##[debug] "ORIGINAL_MESSAGE": false,
2022-02-18T18:17:39.3198704Z ##[debug] "COMMIT_AS_PR_TITLE": false,
2022-02-18T18:17:39.3199258Z ##[debug] "BRANCH_PREFIX": "repo-sync/SOURCE_REPO_NAME",
2022-02-18T18:17:39.3199802Z ##[debug] "FORK": false
2022-02-18T18:17:39.3200221Z ##[debug]}
2022-02-18T18:17:39.3322733Z Repository Info
2022-02-18T18:17:39.3324129Z Slug : sre-test-repo
2022-02-18T18:17:39.3325183Z Owner : cds-snc
2022-02-18T18:17:39.3326034Z Https Url : https://github.com/cds-snc/sre-test-repo
2022-02-18T18:17:39.3327036Z Branch : default
2022-02-18T18:17:39.3327621Z
2022-02-18T18:17:39.3329239Z ##[debug]Cloning github.com/cds-snc/sre-test-repo into tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:39.3331659Z ##[debug]EXEC: "git clone --depth 1 github.com/cds-snc/sre-test-repo.git tmp-1645208259312/github.com/cds-snc/sre-test-repo@default" IN undefined
2022-02-18T18:17:39.5992032Z ##[debug]Setting git user to email: sre-and-tech-ops@cds-snc.ca, username: CalvinRodo
2022-02-18T18:17:39.6001370Z ##[debug]EXEC: "git config --local user.name "CalvinRodo" && git config --local user.email "sre-and-tech-ops@cds-snc.ca"" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:39.6042338Z ##[debug]EXEC: "git rev-parse --abbrev-ref HEAD" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:39.6088942Z ##[debug]EXEC: "git rev-parse HEAD" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:39.6141189Z ##[debug]Creating PR Branch repo-sync/sre-test-repo/default
2022-02-18T18:17:39.6142484Z ##[debug]EXEC: "git checkout -b "repo-sync/sre-test-repo/default"" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:39.8205931Z Found existing PR 3
2022-02-18T18:17:40.5321110Z Locally syncing file(s) between source and target repository
2022-02-18T18:17:40.5332140Z ##[debug]CP: tools/sre_file_sync/s3-backup.yml TO tmp-1645208259312/github.com/cds-snc/sre-test-repo@default/.github/workflows/s3-backup.yml
2022-02-18T18:17:40.5361815Z ##[debug]EXEC: "git add -f ".github/workflows/s3-backup.yml"" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5458895Z ##[debug]EXEC: "git status --porcelain" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5514774Z ##[debug]Creating commit for file(s) .github/workflows/s3-backup.yml
2022-02-18T18:17:40.5516654Z ##[debug]EXEC: "git commit -m '🔄 Created local '''.github/workflows/s3-backup.yml''' from remote '''tools/sre_file_sync/s3-backup.yml''''" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5604183Z ##[debug]EXEC: "git status --porcelain" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5684803Z Pushing changes to target repository
2022-02-18T18:17:40.5688687Z ##[debug]EXEC: "git log --format=%H --reverse main..HEAD" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5736844Z ##[debug]EXEC: "git log -1 --format=%B 2bd23b59b48ffe5bd3095a80dbc37a28ab46c571" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5785475Z ##[debug]EXEC: "git ls-tree -r --full-tree 2bd23b59b48ffe5bd3095a80dbc37a28ab46c571" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5834222Z ##[debug]EXEC: "git show e675925e0c21718ca7e4e28ab1a9549c8f4a8738" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5877752Z ##[debug]EXEC: "git show 18ff6cbfd01c79d6e8383d52fdd0648364026382" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5923337Z ##[debug]EXEC: "git show df6643fe376e42fab9a86d51ee86508faf2ee152" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.5969936Z ##[debug]EXEC: "git show 188ac134c7409f21478ae8a8e5625dd9a07b1e89" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6011879Z ##[debug]EXEC: "git show d2dec503be28fedb76c67f522c256a2038d34a35" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6058063Z ##[debug]EXEC: "git show 9240f7b4f28c4230cbdbc30f57ff7d30bb41ff48" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6102035Z ##[debug]EXEC: "git show a8a69f4c0bd864d71c538a0547b81adbdd4d9b83" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6147240Z ##[debug]EXEC: "git show 44263e81956ce2a591931fb4578abc6d480725cc" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6193639Z ##[debug]EXEC: "git show eabc54db263b548f9b10efaba051e4f03c8f8172" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6238551Z ##[debug]EXEC: "git show 17923302f7e71840a5c83cf0af735606bba9a29f" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6292960Z ##[debug]EXEC: "git show c76b16b3e5bdcfa0112aed4e84c9473048d17a0e" IN tmp-1645208259312/github.com/cds-snc/sre-test-repo@default
2022-02-18T18:17:40.6715195Z ##[error]stdout maxBuffer length exceeded
2022-02-18T18:17:40.6730306Z ##[debug]{"code":"ERR_CHILD_PROCESS_STDIO_MAXBUFFER","cmd":"git show c76b16b3e5bdcfa0112aed4e84c9473048d17a0e"}
2022-02-18T18:17:40.6730826Z
2022-02-18T18:17:40.6731857Z ::set-output name=pull_request_urls::[]
2022-02-18T18:17:40.6732440Z ##[debug]='[]'
2022-02-18T18:17:40.6733234Z ##[debug]RM: tmp-1645208259312
2022-02-18T18:17:40.6855936Z Cleanup complete
2022-02-18T18:17:40.6917521Z ##[debug]Node Action run completed with exit code 1
2022-02-18T18:17:40.6926468Z ##[debug]Finishing: Sync SRE Workflows
2022-02-18T18:17:40.6933821Z ##[debug]Evaluating condition for step: 'Post Run actions/checkout@v2'
2022-02-18T18:17:40.6937374Z ##[debug]Evaluating: always()
2022-02-18T18:17:40.6938097Z ##[debug]Evaluating always:
2022-02-18T18:17:40.6939400Z ##[debug]=> true
2022-02-18T18:17:40.6940232Z ##[debug]Result: true
2022-02-18T18:17:40.6941306Z ##[debug]Starting: Post Run actions/checkout@v2
2022-02-18T18:17:40.6970191Z ##[debug]Loading inputs
2022-02-18T18:17:40.6971540Z ##[debug]Evaluating: github.repository
2022-02-18T18:17:40.6972089Z ##[debug]Evaluating Index:
2022-02-18T18:17:40.6972564Z ##[debug]..Evaluating github:
2022-02-18T18:17:40.6973059Z ##[debug]..=> Object
2022-02-18T18:17:40.6973533Z ##[debug]..Evaluating String:
2022-02-18T18:17:40.6974024Z ##[debug]..=> 'repository'
2022-02-18T18:17:40.6974567Z ##[debug]=> 'cds-snc/sre-test-repo'
2022-02-18T18:17:40.6975092Z ##[debug]Result: 'cds-snc/sre-test-repo'
2022-02-18T18:17:40.6977160Z ##[debug]Evaluating: github.token
2022-02-18T18:17:40.6977689Z ##[debug]Evaluating Index:
2022-02-18T18:17:40.6978160Z ##[debug]..Evaluating github:
2022-02-18T18:17:40.6978618Z ##[debug]..=> Object
2022-02-18T18:17:40.6979078Z ##[debug]..Evaluating String:
2022-02-18T18:17:40.6979514Z ##[debug]..=> 'token'
2022-02-18T18:17:40.6980469Z ##[debug]=> '
'
2022-02-18T18:17:40.6981073Z ##[debug]Result: '
'
2022-02-18T18:17:40.6987069Z ##[debug]Loading env
2022-02-18T18:17:40.6994169Z Post job cleanup.
2022-02-18T18:17:40.8394330Z ##[debug]Getting git version
2022-02-18T18:17:40.8416826Z [command]/usr/bin/git version
2022-02-18T18:17:40.8506361Z git version 2.35.1
2022-02-18T18:17:40.8528435Z ##[debug]Set git useragent to: git/2.35.1 (github-actions-checkout)
2022-02-18T18:17:40.8535565Z ::add-mask::***
2022-02-18T18:17:40.8544017Z [command]/usr/bin/git config --local --name-only --get-regexp core.sshCommand
2022-02-18T18:17:40.8585521Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'core.sshCommand' && git config --local --unset-all 'core.sshCommand' || :
2022-02-18T18:17:40.8879859Z [command]/usr/bin/git config --local --name-only --get-regexp http.https://github.com/.extraheader
2022-02-18T18:17:40.8905052Z http.https://github.com/.extraheader
2022-02-18T18:17:40.8916927Z [command]/usr/bin/git config --local --unset-all http.https://github.com/.extraheader
2022-02-18T18:17:40.8960425Z [command]/usr/bin/git submodule foreach --recursive git config --local --name-only --get-regexp 'http.https://github.com/.extraheader' && git config --local --unset-all 'http.https://github.com/.extraheader' || :
2022-02-18T18:17:40.9306575Z ##[debug]Node Action run completed with exit code 0
2022-02-18T18:17:40.9308990Z ##[debug]Finishing: Post Run actions/checkout@v2
2022-02-18T18:17:40.9455283Z ##[debug]Starting: Complete job
2022-02-18T18:17:40.9457680Z Cleaning up orphan processes
2022-02-18T18:17:40.9894793Z ##[debug]Finishing: Complete job
2022-02-18T18:17:41.0043362Z ##[debug]Finishing: sync_backup_workflow

</p>
</details>  

@alvarezfr
Copy link
Contributor

Hi @BetaHuhn.

Yes totally. The PR #163 was intended to fix the two problems described by @CalvinRodo.

The error stdout maxBuffer length exceeded is related with the change described here: #163 (comment).

Also, the main purpose of the PR was to change the way of pushing files/blobs to GitHub because I found that my previous change causes problems when the encoding is not UTF8. The PR fixes just the two errors described here.

@CalvinRodo if you want to make an aditional test, you can make a run with the proposed change for the PR #163 pointing the action temporally to alvarezfr/repo-file-sync-action@fix/verified_commits

@CalvinRodo
Copy link
Author

@alvarezfr Sounds good, I'm off work right now but will try to get around to running a test this weekend.

@CalvinRodo
Copy link
Author

Okay I just tested out @alvarezfr PR and it fixed the issue.

You can see proof here:

cds-snc/sre-test-repo#3

@alvarezfr
Copy link
Contributor

Okay I just tested out @alvarezfr PR and it fixed the issue.

You can see proof here:

cds-snc/sre-test-repo#3

Thank you for taking time to checking it!

@BetaHuhn
Copy link
Owner

Thanks @alvarezfr for the quick response and @CalvinRodo for testing the fix in #163!

Will review it now and merge it asap.

@BetaHuhn BetaHuhn linked a pull request Feb 19, 2022 that will close this issue
@BetaHuhn BetaHuhn reopened this Feb 19, 2022
@BetaHuhn
Copy link
Owner

Merged and released as v1.17.4. Thanks again @alvarezfr!

@CalvinRodo
Copy link
Author

So just merged the latest action and the problem is now resolved, thanks for all the work folks!

@sammcj
Copy link
Contributor

sammcj commented Nov 29, 2022

This was still an issue for me, but have submitting a fix PR now - #281

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

Successfully merging a pull request may close this issue.

4 participants