[BUG] - Failed in cdk publishAsset during env deployment about aws-orbit-workbench HOT 18 CLOSED

unfortunately there isn't a simple fix for this. the orbit CLI is not managing these uploads, they are being managed by the CDK CLI.

the orbit build is currently using CDK v1.100.0. there was issue opened to the CDK team (aws/aws-cdk#11265) to address this very problem and a PR was issued (aws/aws-cdk#17668). i dug into the CDK releases and found this PR was released with CDK v1.135.0 (https://github.com/aws/aws-cdk/releases/tag/v1.135.0)

as i understand this fix, on cdk deploy the CDK CLI will read the default encryption settings for the bucket and if encryption is set, will update the put requests (including the x-amz-server-side-encryption header).

it should be possible to upgrade the version of the CDK used in the deployment, but this is untested. i am running some preliminary tests to document the steps necessary, and check the S3 API calls to ensure the encryption header is added. i will update here with results.

from aws-orbit-workbench.

so, i've been able to confirm that updating the version of the CDK CLI used for the deployment seems to work. i updated the remote configuration to install CDK v1.135.0 (the minimum with the new functionality) then let it upload assets. i then verified in the CloudTrail logs that the assets are uploaded with the x-amz-server-side-encryption header.

to attempt this is actually pretty easy, you just need to modify the cli/aws_orbit/remote_files/__init__.py file, adding a new install command to the configure function:

configuration.install_commands = ["npm install -g [email protected]"]

from aws-orbit-workbench.

the cloudformation stack for the orbit environment deploys a Lambda function that fires as a post authentication event. this Lambda makes use of a Lambda Layer provided by AWS that enables the kubectl CLI inside the Lambda function. the ARN of this layer is shown above as arn:aws:serverlessrepo:us-east-1:903779448426:applications/lambda-layer-kubectl.

the CDK uses the AWS SAM to create this Lambda Layer. as the error states, there is an explicit DENY preventing the orbit-orbit-eu-central-1-admin Role from calling the serverlessrepo:CreateCloudFormationTemplate and possibly explicitly DENYing cross-account access to the arn:aws:serverlessrepo:us-east-1:903779448426:applications/lambda-layer-kubectl.

are you using a Permissions Boundary Policy attached to the orbit-orbit-eu-central-1-admin Role? it could also be an Organization level DENY that is prohibiting this. with an explicit DENY in place, even updating the orbit-orbit-eu-central-1-admin Role and explicitly Allowing access to the Action and Resource will fail. explicit DENYs trump all other ALLOWs.

from aws-orbit-workbench.

the AWS CDK publishes assets to a toolkit bucket. assets are things like files for S3 or zip files containing Lambda source code. I can't tell from the log snippet where in the cdk deploy it is failing. I suspect permissions on the cdk-toolkit bucket or the Role publishing to it have been scoped down for your hardened account.

if the failure is occurring during orbit's cdk deployment, you can try updating the cli/aws_orbit/cdk.py file, line 44 and adding cdk verbose logging and debugging. this might give you some additional info on the bucket, key, etc.

        "cdk deploy --require-approval never --progress events -vvvvv --debug "

but it's also possible the cdk call is being made by another library orbit uses. I might be able to tell from more of the log if you want to provide here.

from aws-orbit-workbench.

I am not sure why it fails to find the stack ('CDKToolkit') when is there when I view via the console

The toolkit stack deployed successfully.

Error message

[2022-09-13 00:13:58,181][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,320][sh.py : 30] Successfully built f7ab86b0af51
[2022-09-13 00:13:58,181][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,320][sh.py : 30] Successfully tagged cdk-a51e0d345fa2155b309c20166217ef6a61809a1ac8bed99a4675c06393e8b32c:latest
[2022-09-13 00:13:58,181][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,761][sh.py : 30] orbit-orbit: deploying...
[2022-09-13 00:13:58,181][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,769][sh.py : 30] Waiting for stack CDKToolkit to finish creating or updating...
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,853][sh.py : 30] [AWS cloudformation 400 0.085s 0 retries] describeStacks({ StackName: 'CDKToolkit' })
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,854][sh.py : 30] Call failed: describeStacks({"StackName":"CDKToolkit"}) => Stack with id CDKToolkit does not exist (code=ValidationError)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,854][sh.py : 30] Stack CDKToolkit does not exist
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,854][sh.py : 30] The environment aws://352133749271/eu-central-1 doesn't have the CDK toolkit stack (CDKToolkit) installed. Use cdk bootstrap "aws://352133749271/eu-central-1" to setup your environment for use with the toolkit.
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,967][sh.py : 30] [AWS cloudformation 400 0.111s 0 retries] describeStacks({ StackName: 'orbit-orbit' })
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,967][sh.py : 30] Call failed: describeStacks({"StackName":"orbit-orbit"}) => Stack with id orbit-orbit does not exist (code=ValidationError)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30]
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] ❌ orbit-orbit failed: Error: This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://352133749271/eu-central-1")
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at Object.addMetadataAssetsToManifest (/usr/lib/node_modules/aws-cdk/lib/assets.ts:27:11)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at Object.deployStack (/usr/lib/node_modules/aws-cdk/lib/api/deploy-stack.ts:211:29)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at processTicksAndRejections (internal/process/task_queues.js:97:5)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at CdkToolkit.deploy (/usr/lib/node_modules/aws-cdk/lib/cdk-toolkit.ts:180:24)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at initCommandLine (/usr/lib/node_modules/aws-cdk/bin/cdk.ts:208:9)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://352133749271/eu-central-1")
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] Error: This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://352133749271/eu-central-1")
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at Object.addMetadataAssetsToManifest (/usr/lib/node_modules/aws-cdk/lib/assets.ts:27:11)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at Object.deployStack (/usr/lib/node_modules/aws-cdk/lib/api/deploy-stack.ts:211:29)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at processTicksAndRejections (internal/process/task_queues.js:97:5)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at CdkToolkit.deploy (/usr/lib/node_modules/aws-cdk/lib/cdk-toolkit.ts:180:24)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,019][sh.py : 30] at initCommandLine (/usr/lib/node_modules/aws-cdk/bin/cdk.ts:208:9)
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:54,024][sh.py : 30]
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] Traceback (most recent call last):
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/bin/codeseeder", line 8, in
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] sys.exit(main())
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/main.py", line 161, in main
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] cli()
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 829, in call
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] return self.main(*args, **kwargs)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 782, in main
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] rv = self.invoke(ctx)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 1259, in invoke
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] return _process_result(sub_ctx.command.invoke(sub_ctx))
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 1066, in invoke
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] return ctx.invoke(self.callback, **ctx.params)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 610, in invoke
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] return callback(*args, **kwargs)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/main.py", line 153, in execute
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] func(*fn_args["args"], **fn_args["kwargs"])
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/deploy.py", line 398, in deploy_env
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] deploy_env(env_name=env_name, manifest_dir=manifest_dir)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/codeseeder.py", line 229, in wrapper
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] return func(*args, **kwargs)
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/deploy.py", line 376, in deploy_env
[2022-09-13 00:13:58,183][_remote.py : 30] [CODEBUILD] eks_system_masters_roles_changes=changeset.eks_system_masters_roles_changeset if changeset else None,
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/env.py", line 80, in deploy
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] args=args,
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/cdk.py", line 49, in deploy
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] sh.run(cmd=cmd)
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/sh.py", line 29, in run
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] for line in _run_iterating(cmd=cmd, cwd=cwd):
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] File "/root/.venv/lib/python3.7/site-packages/aws_orbit/sh.py", line 23, in _run_iterating
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] raise FailedShellCommand(f"Exit code: {p.returncode}")
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] aws_orbit.exceptions.FailedShellCommand: Exit code: 1
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD]
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Command did not exit successfully codeseeder execute --args-file fn_args.json --debug exit status 1
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Phase complete: BUILD State: FAILED
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Phase context status code: COMMAND_EXECUTION_ERROR Message: Error while executing command: codeseeder execute --args-file fn_args.json --debug. Reason: exit status 1
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Entering phase POST_BUILD
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Running command . ~/.venv/bin/activate
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD]
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Running command cd ${CODEBUILD_SRC_DIR}/bundle
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD]
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Phase complete: POST_BUILD State: SUCCEEDED
[2022-09-13 00:13:58,184][_remote.py : 30] [CODEBUILD] [Container] 2022/09/12 22:13:54 Phase context status code: Message:
[2022-09-13 00:14:04,559][codebuild.py :241] phase: COMPLETED (FAILED)
[ Error ] RuntimeError: CodeBuild build (codeseeder-orbit:24a37b42-c569-474e-a979-a169d33db649) is FAILED

Error Traceback:
Traceback (most recent call last):
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/bin/orbit", line 33, in
sys.exit(load_entry_point('aws-orbit', 'console_scripts', 'orbit')())
File "/Users/qxz1iu6/HSDAP/orbit-public/aws-orbit-workbench-main/cli/aws_orbit/main.py", line 849, in main
cli()
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 829, in call
return self.main(*args, **kwargs)
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 782, in main
rv = self.invoke(ctx)
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 1259, in invoke
return _process_result(sub_ctx.command.invoke(sub_ctx))
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 1259, in invoke
return _process_result(sub_ctx.command.invoke(sub_ctx))
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 1066, in invoke
return ctx.invoke(self.callback, **ctx.params)
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/click/core.py", line 610, in invoke
return callback(*args, **kwargs)
File "/Users/qxz1iu6/HSDAP/orbit-public/aws-orbit-workbench-main/cli/aws_orbit/main.py", line 221, in deploy_env
deploy_commands.deploy_env(
File "/Users/qxz1iu6/HSDAP/orbit-public/aws-orbit-workbench-main/cli/aws_orbit/commands/deploy.py", line 215, in deploy_env
deploy.deploy_env(
File "/Users/qxz1iu6/HSDAP/orbit-public/aws-orbit-workbench-main/cli/aws_orbit/remote_files/deploy.py", line 398, in deploy_env
deploy_env(env_name=env_name, manifest_dir=manifest_dir)
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/aws_codeseeder/codeseeder.py", line 294, in wrapper
_remote.run(
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/aws_codeseeder/_remote.py", line 100, in run
_execute_codebuild(
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/aws_codeseeder/_remote.py", line 80, in _execute_codebuild
_wait_execution(
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/aws_codeseeder/_remote.py", line 42, in _wait_execution
for status in codebuild.wait(build_id=build_id):
File "/Users/qxz1iu6/HSDAP/orbit/aws-orbit-workbench/cli/.venv/lib/python3.8/site-packages/aws_codeseeder/services/codebuild.py", line 246, in wait
raise RuntimeError(f"CodeBuild build ({build_id}) is {build.status.value}")
RuntimeError: CodeBuild build (codeseeder-orbit:24a37b42-c569-474e-a979-a169d33db649) is FAILED
╭─ ~/HSDAP/orbit-public/aws-orbit-workbench-main/cli/conf
╰─

from aws-orbit-workbench.

Without seeing all the assets, my first estimate is that your CDK deployment is incomplete.

[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,853][sh.py : 30] [AWS cloudformation 400 0.085s 0 retries] describeStacks({ StackName: 'CDKToolkit' })
[2022-09-13 00:13:58,182][_remote.py : 30] [CODEBUILD] [2022-09-12 22:13:53,854][sh.py : 30] Call failed: describeStacks({"StackName":"CDKToolkit"}) => Stack with id CDKToolkit does not exist (code=ValidationError)

Check to make sure the stack "CDKToolkit" is in CloudFormation in that region. If so, look at the resources created. You should see the following resources (at least):
CdkBootstrapVersion - an SSM parameter
ContainerAssetsRepository - an ECR repo

Make sure those assets exist. If they do not, you need to rebootstrap (cdk bootstrap aws://xxxxxxxxxxxx/eu-central-1).

from aws-orbit-workbench.

Hi @dgraeber,

I can confirm that the toolkit is in the right region.

orbit-orbit-toolkit

orbit-orbit-cdk-toolkit

from aws-orbit-workbench.

The toolkit, credentials and images stack applied successfully. the problem raises when I apply env stack.

from aws-orbit-workbench.

@bozethe I agree that the orbit toolkits deployed. I am referring to the cdk toolkit (literally named CDKToolkit). The stack trace indicates that did not seem to be found.

If that stack exists and the underlying resources are there, then as @chamcca indicated perhaps the role used to deploy has honed-back permissions to see that stack?

from aws-orbit-workbench.

I checked both ssm parameter store and ecr and there is orbit resources created.
I also tried several time to delete everything and redeploy but I keep on hitting the same error.

from aws-orbit-workbench.

@bozethe Looking at the image you attached, the SSM parameters are unfiltered and I do not see a/cdk-bootstrap/ parameter in SSM, which would have been deployed with a valid CDKToolkit. In that stack, there is also a resource for the cdk repos for ECR .... check if you have those?

Please confirm the resources for the CDKToolkit (unrelated to orbit) are deployed. What version of CDK are you bootstrapped for?

from aws-orbit-workbench.

@bozethe, from your original logs are you able to locate the cdk deploy command that is being executed when this failure occurs? your original logs don't include enough info before the error is thrown. it will be somewhere above the "Step 1/9" in the logs and should look something like this (i have updated mine to appear as i would expect yours to look):

cdk deploy --require-approval never --progress events --toolkit-stack-name orbit-orbit-cdk-toolkit --app "python /root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/cdk/env.py issue" --output .orbit.out/issue/cdk/orbit-orbit

you'll notice that the name of the toolkit stack to use is included in the command (--toolkit-stack-name).

i'd like to confirm that the correct toolkit stack is being passed to the cdk. from the second set of logs you sent, i see this line:

 Call failed: describeStacks({"StackName":"orbit-orbit"}) => Stack with id orbit-orbit does not exist (code=ValidationError)

which leads me to wonder if the wrong toolkit stack name is being supplied upstream.

from aws-orbit-workbench.

also, can you check the value of the CdkToolkit stored in the /orbit/orbit/context and the /orbit/orbit/manifest ParameterStore parameters? there may not be an entry in the /manifest one.

from aws-orbit-workbench.

Below is the contents of "/orbit/orbit/context" for value CdkToolkit
{
"AccountId":"3520000009271",
"CdkToolkit":{
"S3Bucket":"orbit-orbit-cdk-toolkit-3520000009271-lreido",
"StackName":"orbit-orbit-cdk-toolkit"
},

There is no CdkToolkit in /orbit/orbit/manifest parameter.

I believe the correct toolkit stack is passed. see below.

LOGS

[2022-09-14 09:36:05,197][deploy.py :373] CDK Toolkit Stack deployed
[2022-09-14 09:36:05,197][env.py : 60] Stack name: orbit-orbit
[2022-09-14 09:36:05,266][env.py : 36] updating public subnet tags with "kubernetes.io/role/elb"
[2022-09-14 09:36:05,418][env.py : 46] updating private subnet tags with "kubernetes.io/role/internal-elb"
[2022-09-14 09:36:05,543][sh.py : 28] + cdk deploy --require-approval never --progress events -vvvvv --debug--toolkit-stack-name orbit-orbit-cdk-toolkit --app "python /root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/cdk/env.py orbit" --output .orbit.out/orbit/cdk/orbit-orbit
[2022-09-14 09:36:05,954][sh.py : 30] CDK toolkit version: 1.100.0 (build d996c6d)
[2022-09-14 09:36:05,955][sh.py : 30] Command line arguments: {
[2022-09-14 09:36:05,955][sh.py : 30] _: [ 'deploy' ],
[2022-09-14 09:36:05,955][sh.py : 30] 'require-approval': 'never',
[2022-09-14 09:36:05,955][sh.py : 30] requireApproval: 'never',
[2022-09-14 09:36:05,955][sh.py : 30] progress: 'events',
[2022-09-14 09:36:05,956][sh.py : 30] v: 5,
[2022-09-14 09:36:05,956][sh.py : 30] verbose: 5,
[2022-09-14 09:36:05,956][sh.py : 30] 'debug--toolkit-stack-name': 'orbit-orbit-cdk-toolkit',
[2022-09-14 09:36:05,956][sh.py : 30] debugToolkitStackName: 'orbit-orbit-cdk-toolkit',
[2022-09-14 09:36:05,956][sh.py : 30] app: 'python /root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/cdk/env.py orbit',
[2022-09-14 09:36:05,956][sh.py : 30] a: 'python /root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/cdk/env.py orbit',
[2022-09-14 09:36:05,956][sh.py : 30] output: '.orbit.out/orbit/cdk/orbit-orbit',
[2022-09-14 09:36:05,956][sh.py : 30] o: '.orbit.out/orbit/cdk/orbit-orbit',
[2022-09-14 09:36:05,956][sh.py : 30] lookups: true,
[2022-09-14 09:36:05,956][sh.py : 30] 'ignore-errors': false,
[2022-09-14 09:36:05,956][sh.py : 30] ignoreErrors: false,
[2022-09-14 09:36:05,956][sh.py : 30] json: false,
[2022-09-14 09:36:05,956][sh.py : 30] j: false,
[2022-09-14 09:36:05,956][sh.py : 30] debug: false,
[2022-09-14 09:36:05,956][sh.py : 30] ec2creds: undefined,
[2022-09-14 09:36:05,956][sh.py : 30] i: undefined,
[2022-09-14 09:36:05,956][sh.py : 30] 'version-reporting': undefined,
[2022-09-14 09:36:05,956][sh.py : 30] versionReporting: undefined,
[2022-09-14 09:36:05,956][sh.py : 30] 'path-metadata': true,
[2022-09-14 09:36:05,957][sh.py : 30] pathMetadata: true,
[2022-09-14 09:36:05,957][sh.py : 30] 'asset-metadata': true,
[2022-09-14 09:36:05,957][sh.py : 30] assetMetadata: true,
[2022-09-14 09:36:05,957][sh.py : 30] 'role-arn': undefined,
[2022-09-14 09:36:05,957][sh.py : 30] r: undefined,
[2022-09-14 09:36:05,957][sh.py : 30] roleArn: undefined,
[2022-09-14 09:36:05,957][sh.py : 30] staging: true,
[2022-09-14 09:36:05,957][sh.py : 30] 'no-color': false,
[2022-09-14 09:36:05,957][sh.py : 30] noColor: false,
[2022-09-14 09:36:05,957][sh.py : 30] fail: false,
[2022-09-14 09:36:05,957][sh.py : 30] all: false,
[2022-09-14 09:36:05,957][sh.py : 30] 'build-exclude': [],
[2022-09-14 09:36:05,957][sh.py : 30] E: [],
[2022-09-14 09:36:05,957][sh.py : 30] buildExclude: [],
[2022-09-14 09:36:05,957][sh.py : 30] ci: false,
[2022-09-14 09:36:05,957][sh.py : 30] execute: true,
[2022-09-14 09:36:05,957][sh.py : 30] force: false,
[2022-09-14 09:36:05,957][sh.py : 30] f: false,
[2022-09-14 09:36:05,957][sh.py : 30] parameters: [ {} ],
[2022-09-14 09:36:05,957][sh.py : 30] 'previous-parameters': true,
[2022-09-14 09:36:05,957][sh.py : 30] previousParameters: true,
[2022-09-14 09:36:05,958][sh.py : 30] '$0': '/usr/bin/cdk'
[2022-09-14 09:36:05,958][sh.py : 30] }
[2022-09-14 09:36:05,958][sh.py : 30] merged settings: {
[2022-09-14 09:36:05,958][sh.py : 30] versionReporting: true,
[2022-09-14 09:36:05,958][sh.py : 30] pathMetadata: true,
[2022-09-14 09:36:05,958][sh.py : 30] output: '.orbit.out/orbit/cdk/orbit-orbit',
[2022-09-14 09:36:05,958][sh.py : 30] app: 'python /root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/cdk/env.py orbit',
[2022-09-14 09:36:05,958][sh.py : 30] context: {},
[2022-09-14 09:36:05,958][sh.py : 30] debug: false,
[2022-09-14 09:36:05,958][sh.py : 30] assetMetadata: true,
[2022-09-14 09:36:05,958][sh.py : 30] requireApproval: 'never',
[2022-09-14 09:36:05,958][sh.py : 30] toolkitBucket: {},
[2022-09-14 09:36:05,958][sh.py : 30] staging: true,
[2022-09-14 09:36:05,958][sh.py : 30] progress: 'events',
[2022-09-14 09:36:05,959][sh.py : 30] bundlingStacks: [ '' ],
[2022-09-14 09:36:05,959][sh.py : 30] lookups: true
[2022-09-14 09:36:05,959][sh.py : 30] }
[2022-09-14 09:36:05,960][sh.py : 30] Toolkit stack: CDKToolkit
[2022-09-14 09:36:05,960][sh.py : 30] Setting "CDK_DEFAULT_REGION" environment variable to eu-central-1
[2022-09-14 09:36:05,960][sh.py : 30] Resolving default credentials
[2022-09-14 09:36:05,969][sh.py : 30] Retrieved account ID 552000000073 from disk cache
[2022-09-14 09:36:05,969][sh.py : 30] Setting "CDK_DEFAULT_ACCOUNT" environment variable to 552000000073
[2022-09-14 09:36:05,969][sh.py : 30] context: {
[2022-09-14 09:36:05,969][sh.py : 30] 'aws:cdk:enable-path-metadata': true,
[2022-09-14 09:36:05,969][sh.py : 30] 'aws:cdk:enable-asset-metadata': true,
[2022-09-14 09:36:05,969][sh.py : 30] 'aws:cdk:version-reporting': true,
[2022-09-14 09:36:05,969][sh.py : 30] 'aws:cdk:bundling-stacks': [ '' ]
[2022-09-14 09:36:05,969][sh.py : 30] }
[2022-09-14 09:36:05,970][sh.py : 30] outdir: .orbit.out/orbit/cdk/orbit-orbit
[2022-09-14 09:36:05,970][sh.py : 30] env: {
[2022-09-14 09:36:05,970][sh.py : 30] CDK_DEFAULT_REGION: 'eu-central-1',
[2022-09-14 09:36:05,970][sh.py : 30] CDK_DEFAULT_ACCOUNT: '552000000073',
[2022-09-14 09:36:05,970][sh.py : 30] CDK_CONTEXT_JSON: '{"aws:cdk:enable-path-metadata":true,"aws:cdk:enable-asset-metadata":true,"aws:cdk:version-reporting":true,"aws:cdk:bundling-stacks":["*"]}',
[2022-09-14 09:36:05,970][sh.py : 30] CDK_OUTDIR: '.orbit.out/orbit/cdk/orbit-orbit',
[2022-09-14 09:36:05,970][sh.py : 30] CDK_CLI_ASM_VERSION: '9.0.0',
[2022-09-14 09:36:05,970][sh.py : 30] CDK_CLI_VERSION: '1.100.0'
[2022-09-14 09:36:05,970][sh.py : 30] }
time="2022-09-14T09:36:47.175503402Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/7142373cb0c4611b5f470254dad0d566720e83113306138b8e438936466f4190 pid=615
time="2022-09-14T09:36:48.074092164Z" level=info msg="ignoring event" container=7142373cb0c4611b5f470254dad0d566720e83113306138b8e438936466f4190 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:36:48.074753190Z" level=info msg="shim disconnected" id=7142373cb0c4611b5f470254dad0d566720e83113306138b8e438936466f4190
time="2022-09-14T09:36:48.074807153Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:36:48.422271249Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/779671a3053a9491347e72331fc108f9d457cf2906427de7b84ee08dc3da8cee pid=687
time="2022-09-14T09:36:50.803060605Z" level=info msg="ignoring event" container=779671a3053a9491347e72331fc108f9d457cf2906427de7b84ee08dc3da8cee module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:36:50.803688416Z" level=info msg="shim disconnected" id=779671a3053a9491347e72331fc108f9d457cf2906427de7b84ee08dc3da8cee
time="2022-09-14T09:36:50.803746196Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:36:51.566871130Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/7b55de66f3df331ead48edb31ceb105a0b3bc4f9121c35b9447d8fe20b0653fd pid=762
[2022-09-14 09:36:52,950][sh.py : 30] Sending build context to Docker daemon 3.584kB

[2022-09-14 09:36:52,950][sh.py : 30] Step 1/9 : ARG IMAGE=public.ecr.aws/sam/build-python3.7
[2022-09-14 09:36:52,950][sh.py : 30] Step 2/9 : FROM $IMAGE
[2022-09-14 09:36:52,951][sh.py : 30] latest: Pulling from sam/build-python3.8
[2022-09-14 09:36:52,951][sh.py : 30] ffa1311af52a: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] 9cbe0c9e0b47: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] 3ee87f226391: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] ce8e4ede6424: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] a63225a51324: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] b89db7eadea8: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] 29f3b61695b0: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] cd33c77d3484: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] 11dd2bd818bf: Pulling fs layer
[2022-09-14 09:36:52,951][sh.py : 30] ce8e4ede6424: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] a63225a51324: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] b89db7eadea8: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] 29f3b61695b0: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] cd33c77d3484: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] 11dd2bd818bf: Waiting
[2022-09-14 09:36:52,951][sh.py : 30] 9cbe0c9e0b47: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] 9cbe0c9e0b47: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] 3ee87f226391: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] 3ee87f226391: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] ffa1311af52a: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] ffa1311af52a: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] ce8e4ede6424: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] ce8e4ede6424: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] 29f3b61695b0: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] 29f3b61695b0: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] b89db7eadea8: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] b89db7eadea8: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] cd33c77d3484: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] cd33c77d3484: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] 11dd2bd818bf: Verifying Checksum
[2022-09-14 09:36:52,951][sh.py : 30] 11dd2bd818bf: Download complete
[2022-09-14 09:36:52,951][sh.py : 30] ffa1311af52a: Pull complete
[2022-09-14 09:36:52,951][sh.py : 30] 9cbe0c9e0b47: Pull complete
[2022-09-14 09:36:52,951][sh.py : 30] a63225a51324: Verifying Checksum
[2022-09-14 09:36:52,952][sh.py : 30] a63225a51324: Download complete
[2022-09-14 09:36:52,952][sh.py : 30] 3ee87f226391: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] ce8e4ede6424: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] a63225a51324: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] b89db7eadea8: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] 29f3b61695b0: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] cd33c77d3484: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] 11dd2bd818bf: Pull complete
[2022-09-14 09:36:52,952][sh.py : 30] Digest: sha256:e49b1f5fbe105cf14ed831ba8008d5f67ba1b6b2b68936b5d6b8093a88561e23
[2022-09-14 09:36:52,952][sh.py : 30] Status: Downloaded newer image for public.ecr.aws/sam/build-python3.8:latest
[2022-09-14 09:36:52,952][sh.py : 30] ---> 5ba9eef1a641
[2022-09-14 09:36:52,952][sh.py : 30] Step 3/9 : RUN yum -q list installed rsync &>/dev/null || yum install -y rsync
[2022-09-14 09:36:52,952][sh.py : 30] ---> Running in 7142373cb0c4
[2022-09-14 09:36:52,952][sh.py : 30] Removing intermediate container 7142373cb0c4
[2022-09-14 09:36:52,952][sh.py : 30] ---> 276433b1b750
[2022-09-14 09:36:52,952][sh.py : 30] Step 4/9 : RUN pip install --upgrade pip
[2022-09-14 09:36:52,952][sh.py : 30] ---> Running in 779671a3053a
[2022-09-14 09:36:52,952][sh.py : 30] Requirement already satisfied: pip in /var/lang/lib/python3.8/site-packages (22.0.4)
[2022-09-14 09:36:52,952][sh.py : 30] Collecting pip
[2022-09-14 09:36:52,952][sh.py : 30] Downloading pip-22.2.2-py3-none-any.whl (2.0 MB)
[2022-09-14 09:36:52,953][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.0/2.0 MB 97.3 MB/s eta 0:00:00
[2022-09-14 09:36:52,953][sh.py : 30] Installing collected packages: pip
[2022-09-14 09:36:52,953][sh.py : 30] Attempting uninstall: pip
[2022-09-14 09:36:52,953][sh.py : 30] Found existing installation: pip 22.0.4
[2022-09-14 09:36:52,953][sh.py : 30] Uninstalling pip-22.0.4:
[2022-09-14 09:36:52,953][sh.py : 30] Successfully uninstalled pip-22.0.4
[2022-09-14 09:36:52,953][sh.py : 30] Successfully installed pip-22.2.2
[2022-09-14 09:36:52,953][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:36:52,953][sh.py : 30] Removing intermediate container 779671a3053a
[2022-09-14 09:36:52,953][sh.py : 30] ---> b61c52ccc349
[2022-09-14 09:36:52,953][sh.py : 30] Step 5/9 : RUN pip install pipenv poetry
[2022-09-14 09:36:52,953][sh.py : 30] ---> Running in 7b55de66f3df
[2022-09-14 09:36:52,953][sh.py : 30] Collecting pipenv
[2022-09-14 09:36:52,953][sh.py : 30] Downloading pipenv-2022.9.8-py2.py3-none-any.whl (3.3 MB)
[2022-09-14 09:36:52,953][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.3/3.3 MB 104.9 MB/s eta 0:00:00
[2022-09-14 09:36:52,953][sh.py : 30] Collecting poetry
[2022-09-14 09:36:52,953][sh.py : 30] Downloading poetry-1.2.0-py3-none-any.whl (210 kB)
[2022-09-14 09:36:52,953][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 210.9/210.9 kB 46.4 MB/s eta 0:00:00
[2022-09-14 09:36:52,953][sh.py : 30] Requirement already satisfied: setuptools>=36.2.1 in /var/lang/lib/python3.8/site-packages (from pipenv) (56.0.0)
[2022-09-14 09:36:52,953][sh.py : 30] Collecting certifi
[2022-09-14 09:36:52,953][sh.py : 30] Downloading certifi-2022.6.15.2-py3-none-any.whl (160 kB)
[2022-09-14 09:36:52,954][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.4/160.4 kB 36.4 MB/s eta 0:00:00
[2022-09-14 09:36:52,954][sh.py : 30] Collecting virtualenv-clone>=0.2.5
[2022-09-14 09:36:52,954][sh.py : 30] Downloading virtualenv_clone-0.5.7-py3-none-any.whl (6.6 kB)
[2022-09-14 09:36:52,954][sh.py : 30] Collecting virtualenv
[2022-09-14 09:36:52,954][sh.py : 30] Downloading virtualenv-20.16.5-py3-none-any.whl (8.8 MB)
[2022-09-14 09:36:52,954][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 8.8/8.8 MB 124.2 MB/s eta 0:00:00
[2022-09-14 09:36:52,954][sh.py : 30] Collecting poetry-plugin-export<2.0.0,>=1.0.6
[2022-09-14 09:36:52,954][sh.py : 30] Downloading poetry_plugin_export-1.0.6-py3-none-any.whl (9.6 kB)
[2022-09-14 09:36:52,954][sh.py : 30] Collecting html5lib<2.0,>=1.0
[2022-09-14 09:36:52,954][sh.py : 30] Downloading html5lib-1.1-py2.py3-none-any.whl (112 kB)
[2022-09-14 09:36:54,055][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 112.2/112.2 kB 27.8 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting requests<3.0,>=2.18
[2022-09-14 09:36:54,056][sh.py : 30] Downloading requests-2.28.1-py3-none-any.whl (62 kB)
[2022-09-14 09:36:54,056][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.8/62.8 kB 16.9 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting keyring>=21.2.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading keyring-23.9.1-py3-none-any.whl (35 kB)
[2022-09-14 09:36:54,056][sh.py : 30] Collecting requests-toolbelt<0.10.0,>=0.9.1
[2022-09-14 09:36:54,056][sh.py : 30] Downloading requests_toolbelt-0.9.1-py2.py3-none-any.whl (54 kB)
[2022-09-14 09:36:54,056][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.3/54.3 kB 15.2 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting cachy<0.4.0,>=0.3.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading cachy-0.3.0-py2.py3-none-any.whl (20 kB)
[2022-09-14 09:36:54,056][sh.py : 30] Collecting pexpect<5.0.0,>=4.7.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading pexpect-4.8.0-py2.py3-none-any.whl (59 kB)
[2022-09-14 09:36:54,056][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 59.0/59.0 kB 16.1 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting cachecontrol[filecache]<0.13.0,>=0.12.9
[2022-09-14 09:36:54,056][sh.py : 30] Downloading CacheControl-0.12.11-py2.py3-none-any.whl (21 kB)
[2022-09-14 09:36:54,056][sh.py : 30] Collecting poetry-core==1.1.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading poetry_core-1.1.0-py3-none-any.whl (526 kB)
[2022-09-14 09:36:54,056][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 526.2/526.2 kB 70.2 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting jsonschema<5.0.0,>=4.10.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading jsonschema-4.16.0-py3-none-any.whl (83 kB)
[2022-09-14 09:36:54,056][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 83.1/83.1 kB 22.0 MB/s eta 0:00:00
[2022-09-14 09:36:54,056][sh.py : 30] Collecting crashtest<0.4.0,>=0.3.0
[2022-09-14 09:36:54,056][sh.py : 30] Downloading crashtest-0.3.1-py3-none-any.whl (7.0 kB)
[2022-09-14 09:36:54,056][sh.py : 30] Collecting importlib-metadata<5.0,>=4.4
[2022-09-14 09:36:54,057][sh.py : 30] Downloading importlib_metadata-4.12.0-py3-none-any.whl (21 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting urllib3<2.0.0,>=1.26.0
[2022-09-14 09:36:54,057][sh.py : 30] Downloading urllib3-1.26.12-py2.py3-none-any.whl (140 kB)
[2022-09-14 09:36:54,057][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 140.4/140.4 kB 28.0 MB/s eta 0:00:00
[2022-09-14 09:36:54,057][sh.py : 30] Collecting tomlkit!=0.11.2,!=0.11.3,<1.0.0,>=0.11.1
[2022-09-14 09:36:54,057][sh.py : 30] Downloading tomlkit-0.11.4-py3-none-any.whl (35 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting cleo<2.0.0,>=1.0.0a5
[2022-09-14 09:36:54,057][sh.py : 30] Downloading cleo-1.0.0a5-py3-none-any.whl (78 kB)
[2022-09-14 09:36:54,057][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 78.7/78.7 kB 23.5 MB/s eta 0:00:00
[2022-09-14 09:36:54,057][sh.py : 30] Collecting pkginfo<2.0,>=1.5
[2022-09-14 09:36:54,057][sh.py : 30] Downloading pkginfo-1.8.3-py2.py3-none-any.whl (26 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting platformdirs<3.0.0,>=2.5.2
[2022-09-14 09:36:54,057][sh.py : 30] Downloading platformdirs-2.5.2-py3-none-any.whl (14 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting shellingham<2.0,>=1.5
[2022-09-14 09:36:54,057][sh.py : 30] Downloading shellingham-1.5.0-py2.py3-none-any.whl (9.3 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting dulwich<0.21.0,>=0.20.44
[2022-09-14 09:36:54,057][sh.py : 30] Downloading dulwich-0.20.46-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (499 kB)
[2022-09-14 09:36:54,057][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 499.9/499.9 kB 77.4 MB/s eta 0:00:00
[2022-09-14 09:36:54,057][sh.py : 30] Collecting packaging>=20.4
[2022-09-14 09:36:54,057][sh.py : 30] Downloading packaging-21.3-py3-none-any.whl (40 kB)
[2022-09-14 09:36:54,057][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 12.6 MB/s eta 0:00:00
[2022-09-14 09:36:54,057][sh.py : 30] Collecting msgpack>=0.5.2
[2022-09-14 09:36:54,057][sh.py : 30] Downloading msgpack-1.0.4-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (322 kB)
[2022-09-14 09:36:54,057][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 322.5/322.5 kB 55.9 MB/s eta 0:00:00
[2022-09-14 09:36:54,057][sh.py : 30] Collecting lockfile>=0.9
[2022-09-14 09:36:54,057][sh.py : 30] Downloading lockfile-0.12.2-py2.py3-none-any.whl (13 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting pylev<2.0.0,>=1.3.0
[2022-09-14 09:36:54,057][sh.py : 30] Downloading pylev-1.4.0-py2.py3-none-any.whl (6.1 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting webencodings
[2022-09-14 09:36:54,057][sh.py : 30] Downloading webencodings-0.5.1-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting six>=1.9
[2022-09-14 09:36:54,057][sh.py : 30] Downloading six-1.16.0-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting zipp>=0.5
[2022-09-14 09:36:54,057][sh.py : 30] Downloading zipp-3.8.1-py3-none-any.whl (5.6 kB)
[2022-09-14 09:36:54,057][sh.py : 30] Collecting pkgutil-resolve-name>=1.3.10
[2022-09-14 09:36:59,676][sh.py : 30] Downloading pkgutil_resolve_name-1.3.10-py3-none-any.whl (4.7 kB)
[2022-09-14 09:36:59,677][sh.py : 30] Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0
[2022-09-14 09:36:59,677][sh.py : 30] Downloading pyrsistent-0.18.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (119 kB)
[2022-09-14 09:36:59,677][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.8/119.8 kB 34.2 MB/s eta 0:00:00
[2022-09-14 09:36:59,677][sh.py : 30] Collecting importlib-resources>=1.4.0
[2022-09-14 09:36:59,677][sh.py : 30] Downloading importlib_resources-5.9.0-py3-none-any.whl (33 kB)
[2022-09-14 09:36:59,677][sh.py : 30] Collecting attrs>=17.4.0
[2022-09-14 09:36:59,677][sh.py : 30] Downloading attrs-22.1.0-py2.py3-none-any.whl (58 kB)
[2022-09-14 09:36:59,677][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.8/58.8 kB 20.1 MB/s eta 0:00:00
[2022-09-14 09:36:59,677][sh.py : 30] Collecting SecretStorage>=3.2
[2022-09-14 09:36:59,677][sh.py : 30] Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
[2022-09-14 09:36:59,677][sh.py : 30] Collecting jeepney>=0.4.2
[2022-09-14 09:36:59,677][sh.py : 30] Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
[2022-09-14 09:36:59,677][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 kB 16.6 MB/s eta 0:00:00
[2022-09-14 09:36:59,677][sh.py : 30] Collecting jaraco.classes
[2022-09-14 09:36:59,677][sh.py : 30] Downloading jaraco.classes-3.2.2-py3-none-any.whl (6.0 kB)
[2022-09-14 09:36:59,677][sh.py : 30] Collecting pyparsing!=3.0.5,>=2.0.2
[2022-09-14 09:36:59,677][sh.py : 30] Downloading pyparsing-3.0.9-py3-none-any.whl (98 kB)
[2022-09-14 09:36:59,677][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.3/98.3 kB 30.2 MB/s eta 0:00:00
[2022-09-14 09:36:59,678][sh.py : 30] Collecting ptyprocess>=0.5
[2022-09-14 09:36:59,678][sh.py : 30] Downloading ptyprocess-0.7.0-py2.py3-none-any.whl (13 kB)
[2022-09-14 09:36:59,678][sh.py : 30] Collecting charset-normalizer<3,>=2
[2022-09-14 09:36:59,678][sh.py : 30] Downloading charset_normalizer-2.1.1-py3-none-any.whl (39 kB)
[2022-09-14 09:36:59,678][sh.py : 30] Collecting idna<4,>=2.5
[2022-09-14 09:36:59,678][sh.py : 30] Downloading idna-3.4-py3-none-any.whl (61 kB)
[2022-09-14 09:36:59,678][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.5/61.5 kB 18.7 MB/s eta 0:00:00
[2022-09-14 09:36:59,678][sh.py : 30] Collecting filelock<4,>=3.4.1
[2022-09-14 09:36:59,678][sh.py : 30] Downloading filelock-3.8.0-py3-none-any.whl (10 kB)
[2022-09-14 09:36:59,678][sh.py : 30] Collecting distlib<1,>=0.3.5
[2022-09-14 09:36:59,678][sh.py : 30] Downloading distlib-0.3.6-py2.py3-none-any.whl (468 kB)
[2022-09-14 09:36:59,678][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 468.5/468.5 kB 55.0 MB/s eta 0:00:00
[2022-09-14 09:36:59,678][sh.py : 30] Collecting cryptography>=2.0
[2022-09-14 09:36:59,678][sh.py : 30] Downloading cryptography-38.0.1-cp36-abi3-manylinux_2_24_x86_64.whl (4.0 MB)
[2022-09-14 09:36:59,678][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.0/4.0 MB 124.9 MB/s eta 0:00:00
[2022-09-14 09:36:59,678][sh.py : 30] Collecting more-itertools
[2022-09-14 09:36:59,678][sh.py : 30] Downloading more_itertools-8.14.0-py3-none-any.whl (52 kB)
[2022-09-14 09:36:59,678][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 52.2/52.2 kB 16.4 MB/s eta 0:00:00
[2022-09-14 09:36:59,678][sh.py : 30] Collecting cffi>=1.12
[2022-09-14 09:36:59,678][sh.py : 30] Downloading cffi-1.15.1-cp38-cp38-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (442 kB)
[2022-09-14 09:36:59,678][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 442.7/442.7 kB 73.8 MB/s eta 0:00:00
[2022-09-14 09:36:59,679][sh.py : 30] Collecting pycparser
[2022-09-14 09:36:59,679][sh.py : 30] Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB)
[2022-09-14 09:36:59,679][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.7/118.7 kB 33.4 MB/s eta 0:00:00
[2022-09-14 09:36:59,679][sh.py : 30] Installing collected packages: webencodings, pylev, ptyprocess, msgpack, lockfile, distlib, zipp, virtualenv-clone, urllib3, tomlkit, six, shellingham, pyrsistent, pyparsing, pycparser, poetry-core, platformdirs, pkgutil-resolve-name, pkginfo, pexpect, more-itertools, jeepney, idna, filelock, crashtest, charset-normalizer, certifi, cachy, attrs, virtualenv, requests, packaging, jaraco.classes, importlib-resources, importlib-metadata, html5lib, dulwich, cleo, cffi, requests-toolbelt, pipenv, jsonschema, cryptography, cachecontrol, SecretStorage, keyring, poetry-plugin-export, poetry
time="2022-09-14T09:36:59.870885370Z" level=info msg="ignoring event" container=7b55de66f3df331ead48edb31ceb105a0b3bc4f9121c35b9447d8fe20b0653fd module=libcontainerd namespace=moby topic=/tasks/delete type="events.TaskDelete"
time="2022-09-14T09:36:59.871251306Z" level=info msg="shim disconnected" id=7b55de66f3df331ead48edb31ceb105a0b3bc4f9121c35b9447d8fe20b0653fd
time="2022-09-14T09:36:59.871314410Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:02.441658751Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/701f784470637d689ab12d6c7c829a6f06585b81a7309a1ca2eb9a713ba966fe pid=879
time="2022-09-14T09:37:04.523043300Z" level=info msg="ignoring event" container=701f784470637d689ab12d6c7c829a6f06585b81a7309a1ca2eb9a713ba966fe module=libcontainerd namespace=moby topic=/tasks/delete type="events.TaskDelete"
time="2022-09-14T09:37:04.523696176Z" level=info msg="shim disconnected" id=701f784470637d689ab12d6c7c829a6f06585b81a7309a1ca2eb9a713ba966fe
time="2022-09-14T09:37:04.523747603Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:05.094339190Z" level=info msg="Layer sha256:413de18bb4f9a823673f5e981de4183d483aa7bcfde10880c205c6238f4420dd cleaned up"
[2022-09-14 09:37:05,157][sh.py : 30] Successfully installed SecretStorage-3.3.3 attrs-22.1.0 cachecontrol-0.12.11 cachy-0.3.0 certifi-2022.6.15.2 cffi-1.15.1 charset-normalizer-2.1.1 cleo-1.0.0a5 crashtest-0.3.1 cryptography-38.0.1 distlib-0.3.6 dulwich-0.20.46 filelock-3.8.0 html5lib-1.1 idna-3.4 importlib-metadata-4.12.0 importlib-resources-5.9.0 jaraco.classes-3.2.2 jeepney-0.8.0 jsonschema-4.16.0 keyring-23.9.1 lockfile-0.12.2 more-itertools-8.14.0 msgpack-1.0.4 packaging-21.3 pexpect-4.8.0 pipenv-2022.9.8 pkginfo-1.8.3 pkgutil-resolve-name-1.3.10 platformdirs-2.5.2 poetry-1.2.0 poetry-core-1.1.0 poetry-plugin-export-1.0.6 ptyprocess-0.7.0 pycparser-2.21 pylev-1.4.0 pyparsing-3.0.9 pyrsistent-0.18.1 requests-2.28.1 requests-toolbelt-0.9.1 shellingham-1.5.0 six-1.16.0 tomlkit-0.11.4 urllib3-1.26.12 virtualenv-20.16.5 virtualenv-clone-0.5.7 webencodings-0.5.1 zipp-3.8.1
[2022-09-14 09:37:05,158][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:37:05,158][sh.py : 30] Removing intermediate container 7b55de66f3df
[2022-09-14 09:37:05,158][sh.py : 30] ---> 15a836b834c5
[2022-09-14 09:37:05,158][sh.py : 30] Step 6/9 : WORKDIR /var/dependencies
[2022-09-14 09:37:05,158][sh.py : 30] ---> Running in 5c93bc319e62
[2022-09-14 09:37:05,158][sh.py : 30] Removing intermediate container 5c93bc319e62
[2022-09-14 09:37:05,158][sh.py : 30] ---> 69dc1b35af27
[2022-09-14 09:37:05,158][sh.py : 30] Step 7/9 : COPY Pipfile pyproject poetry* requirements.tx[t] ./
[2022-09-14 09:37:05,158][sh.py : 30] ---> 963341a5959a
[2022-09-14 09:37:05,158][sh.py : 30] Step 8/9 : RUN [ -f 'Pipfile' ] && pipenv lock -r >requirements.txt; [ -f 'poetry.lock' ] && poetry export --with-credentials --format requirements.txt --output requirements.txt; [ -f 'requirements.txt' ] && pip install -r requirements.txt -t .;
[2022-09-14 09:37:05,158][sh.py : 30] ---> Running in 701f78447063
[2022-09-14 09:37:05,158][sh.py : 30] Collecting requests~=2.25.1
[2022-09-14 09:37:05,158][sh.py : 30] Downloading requests-2.25.1-py2.py3-none-any.whl (61 kB)
[2022-09-14 09:37:05,158][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.2/61.2 kB 15.2 MB/s eta 0:00:00
[2022-09-14 09:37:05,158][sh.py : 30] Collecting python-jose~=3.2.0
[2022-09-14 09:37:05,158][sh.py : 30] Downloading python_jose-3.2.0-py2.py3-none-any.whl (26 kB)
[2022-09-14 09:37:05,158][sh.py : 30] Collecting idna<3,>=2.5
[2022-09-14 09:37:05,158][sh.py : 30] Downloading idna-2.10-py2.py3-none-any.whl (58 kB)
[2022-09-14 09:37:05,158][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.8/58.8 kB 15.2 MB/s eta 0:00:00
[2022-09-14 09:37:05,158][sh.py : 30] Collecting urllib3<1.27,>=1.21.1
[2022-09-14 09:37:05,158][sh.py : 30] Using cached urllib3-1.26.12-py2.py3-none-any.whl (140 kB)
[2022-09-14 09:37:05,159][sh.py : 30] Collecting chardet<5,>=3.0.2
[2022-09-14 09:37:05,159][sh.py : 30] Downloading chardet-4.0.0-py2.py3-none-any.whl (178 kB)
[2022-09-14 09:37:05,159][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 178.7/178.7 kB 45.1 MB/s eta 0:00:00
[2022-09-14 09:37:05,159][sh.py : 30] Collecting certifi>=2017.4.17
[2022-09-14 09:37:05,159][sh.py : 30] Using cached certifi-2022.6.15.2-py3-none-any.whl (160 kB)
[2022-09-14 09:37:05,159][sh.py : 30] Collecting rsa
[2022-09-14 09:37:05,159][sh.py : 30] Downloading rsa-4.9-py3-none-any.whl (34 kB)
[2022-09-14 09:37:05,159][sh.py : 30] Collecting ecdsa<0.15
[2022-09-14 09:37:05,159][sh.py : 30] Downloading ecdsa-0.14.1-py2.py3-none-any.whl (79 kB)
[2022-09-14 09:37:05,159][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 79.4/79.4 kB 17.5 MB/s eta 0:00:00
[2022-09-14 09:37:05,159][sh.py : 30] Collecting pyasn1
[2022-09-14 09:37:05,159][sh.py : 30] Downloading pyasn1-0.4.8-py2.py3-none-any.whl (77 kB)
[2022-09-14 09:37:05,159][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 77.1/77.1 kB 20.6 MB/s eta 0:00:00
[2022-09-14 09:37:05,159][sh.py : 30] Collecting six<2.0
[2022-09-14 09:37:05,159][sh.py : 30] Using cached six-1.16.0-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:37:05,159][sh.py : 30] Installing collected packages: pyasn1, urllib3, six, rsa, idna, chardet, certifi, requests, ecdsa, python-jose
[2022-09-14 09:37:05,159][sh.py : 30] Successfully installed certifi-2022.6.15.2 chardet-4.0.0 ecdsa-0.14.1 idna-2.10 pyasn1-0.4.8 python-jose-3.2.0 requests-2.25.1 rsa-4.9 six-1.16.0 urllib3-1.26.12
[2022-09-14 09:37:05,159][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:37:05,159][sh.py : 30] Removing intermediate container 701f78447063
[2022-09-14 09:37:05,159][sh.py : 30] ---> eecf34d817d4
[2022-09-14 09:37:05,159][sh.py : 30] Step 9/9 : CMD [ "python" ]
[2022-09-14 09:37:05,159][sh.py : 30] ---> Running in 3a6dbd16146a
[2022-09-14 09:37:05,159][sh.py : 30] Removing intermediate container 3a6dbd16146a
[2022-09-14 09:37:05,160][sh.py : 30] ---> 2be3b4f89231
[2022-09-14 09:37:05,160][sh.py : 30] Successfully built 2be3b4f89231
[2022-09-14 09:37:05,160][sh.py : 30] Successfully tagged cdk-a507681a5c25a96317cab4b638bdd786b58957ae4c3c64dd2909dafb39f39446:latest
time="2022-09-14T09:37:05.288832463Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/c487622a465b3538894e144e7c18c4b30483d7ce999dbb199a65329156d50e0a pid=977
time="2022-09-14T09:37:05.789106183Z" level=info msg="ignoring event" container=c487622a465b3538894e144e7c18c4b30483d7ce999dbb199a65329156d50e0a module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:37:05.789694297Z" level=info msg="shim disconnected" id=c487622a465b3538894e144e7c18c4b30483d7ce999dbb199a65329156d50e0a
time="2022-09-14T09:37:05.789735101Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:06.175815646Z" level=info msg="Layer sha256:82a4db11ba9f1bd78b3b04aeb3812b4f44139a92df26c7e98d81ee52c9e80301 cleaned up"
time="2022-09-14T09:37:06.338683283Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/afa13a43abd6095f446a80cb2e8d5b55436ee5cb802f6599ac72d8be1ee0201f pid=1075
time="2022-09-14T09:37:06.812925537Z" level=info msg="ignoring event" container=afa13a43abd6095f446a80cb2e8d5b55436ee5cb802f6599ac72d8be1ee0201f module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:37:06.813566458Z" level=info msg="shim disconnected" id=afa13a43abd6095f446a80cb2e8d5b55436ee5cb802f6599ac72d8be1ee0201f
time="2022-09-14T09:37:06.813608684Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:38.225814092Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/118acfef7d5fd2455e282daee70a07b0adbb7081419afdbecc734772b31eb942 pid=1249
time="2022-09-14T09:37:39.465292990Z" level=info msg="ignoring event" container=118acfef7d5fd2455e282daee70a07b0adbb7081419afdbecc734772b31eb942 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:37:39.465899844Z" level=info msg="shim disconnected" id=118acfef7d5fd2455e282daee70a07b0adbb7081419afdbecc734772b31eb942
time="2022-09-14T09:37:39.465938574Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:39.941855886Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/352c7d210047fac91c5b913c2e0f771e651880775aaa8fd6e1d798f3eb49ef98 pid=1324
time="2022-09-14T09:37:42.515029171Z" level=info msg="ignoring event" container=352c7d210047fac91c5b913c2e0f771e651880775aaa8fd6e1d798f3eb49ef98 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:37:42.515759627Z" level=info msg="shim disconnected" id=352c7d210047fac91c5b913c2e0f771e651880775aaa8fd6e1d798f3eb49ef98
time="2022-09-14T09:37:42.515808492Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:43.186221794Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/32404f48999a94ffffa65345b221f1b7c6369d13b61e6dfb120fc2a6543d9bae pid=1400
[2022-09-14 09:37:44,305][sh.py : 30] Bundling asset orbit-orbit/token_validation_lambda/Code/Stage...
[2022-09-14 09:37:44,306][sh.py : 30] Sending build context to Docker daemon 2.048kB

[2022-09-14 09:37:44,306][sh.py : 30] Step 1/4 : ARG IMAGE=public.ecr.aws/sam/build-python3.7
[2022-09-14 09:37:44,306][sh.py : 30] Step 2/4 : FROM $IMAGE
[2022-09-14 09:37:44,306][sh.py : 30] ---> 5ba9eef1a641
[2022-09-14 09:37:44,306][sh.py : 30] Step 3/4 : RUN yum -q list installed rsync &>/dev/null || yum install -y rsync
[2022-09-14 09:37:44,306][sh.py : 30] ---> Using cache
[2022-09-14 09:37:44,306][sh.py : 30] ---> 276433b1b750
[2022-09-14 09:37:44,306][sh.py : 30] Step 4/4 : CMD [ "python" ]
[2022-09-14 09:37:44,306][sh.py : 30] ---> Running in ff43928efc26
[2022-09-14 09:37:44,306][sh.py : 30] Removing intermediate container ff43928efc26
[2022-09-14 09:37:44,306][sh.py : 30] ---> c3f9a966cfa1
[2022-09-14 09:37:44,306][sh.py : 30] Successfully built c3f9a966cfa1
[2022-09-14 09:37:44,306][sh.py : 30] Successfully tagged cdk-2607fa8b1e3b74735da56b8f1c9e26293d29e965ab1c2f9efb5b8f8b639032a0:latest
[2022-09-14 09:37:44,306][sh.py : 30] Bundling asset orbit-orbit/eks_service_lambda/Code/Stage...
[2022-09-14 09:37:44,306][sh.py : 30] Sending build context to Docker daemon 3.584kB

[2022-09-14 09:37:44,306][sh.py : 30] Step 1/9 : ARG IMAGE=public.ecr.aws/sam/build-python3.7
[2022-09-14 09:37:44,306][sh.py : 30] Step 2/9 : FROM $IMAGE
[2022-09-14 09:37:44,306][sh.py : 30] latest: Pulling from sam/build-python3.7
[2022-09-14 09:37:44,306][sh.py : 30] 80c44bd2c8a9: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] af1bf55d9b3f: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] 15d299631b97: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] ed21b88a2918: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] 6cfcb32b35e8: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] f9823b467f71: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] b499d750090f: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] 13a833f7ab64: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] 1b1a54cd5889: Pulling fs layer
[2022-09-14 09:37:44,307][sh.py : 30] ed21b88a2918: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] 6cfcb32b35e8: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] f9823b467f71: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] b499d750090f: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] 13a833f7ab64: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] 1b1a54cd5889: Waiting
[2022-09-14 09:37:44,307][sh.py : 30] af1bf55d9b3f: Verifying Checksum
[2022-09-14 09:37:44,307][sh.py : 30] af1bf55d9b3f: Download complete
[2022-09-14 09:37:44,307][sh.py : 30] 15d299631b97: Verifying Checksum
[2022-09-14 09:37:44,307][sh.py : 30] 15d299631b97: Download complete
[2022-09-14 09:37:44,307][sh.py : 30] ed21b88a2918: Verifying Checksum
[2022-09-14 09:37:44,307][sh.py : 30] ed21b88a2918: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] f9823b467f71: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] f9823b467f71: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] b499d750090f: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] b499d750090f: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] 6cfcb32b35e8: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] 6cfcb32b35e8: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] 80c44bd2c8a9: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] 80c44bd2c8a9: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] 13a833f7ab64: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] 13a833f7ab64: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] 1b1a54cd5889: Verifying Checksum
[2022-09-14 09:37:44,308][sh.py : 30] 1b1a54cd5889: Download complete
[2022-09-14 09:37:44,308][sh.py : 30] 80c44bd2c8a9: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] af1bf55d9b3f: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] 15d299631b97: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] ed21b88a2918: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] 6cfcb32b35e8: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] f9823b467f71: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] b499d750090f: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] 13a833f7ab64: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] 1b1a54cd5889: Pull complete
[2022-09-14 09:37:44,308][sh.py : 30] Digest: sha256:394128fbaf3ed648dbefb8c27f6644a4464fde59ec7021a97311d5ce9db7b04c
[2022-09-14 09:37:44,308][sh.py : 30] Status: Downloaded newer image for public.ecr.aws/sam/build-python3.7:latest
[2022-09-14 09:37:44,308][sh.py : 30] ---> 8b7735bbc14b
[2022-09-14 09:37:44,308][sh.py : 30] Step 3/9 : RUN yum -q list installed rsync &>/dev/null || yum install -y rsync
[2022-09-14 09:37:44,308][sh.py : 30] ---> Running in 118acfef7d5f
[2022-09-14 09:37:44,308][sh.py : 30] Removing intermediate container 118acfef7d5f
[2022-09-14 09:37:44,308][sh.py : 30] ---> 94541a718b94
[2022-09-14 09:37:44,309][sh.py : 30] Step 4/9 : RUN pip install --upgrade pip
[2022-09-14 09:37:44,309][sh.py : 30] ---> Running in 352c7d210047
[2022-09-14 09:37:44,309][sh.py : 30] Requirement already satisfied: pip in /var/lang/lib/python3.7/site-packages (22.0.4)
[2022-09-14 09:37:44,309][sh.py : 30] Collecting pip
[2022-09-14 09:37:44,309][sh.py : 30] Downloading pip-22.2.2-py3-none-any.whl (2.0 MB)
[2022-09-14 09:37:44,309][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.0/2.0 MB 36.8 MB/s eta 0:00:00
[2022-09-14 09:37:44,309][sh.py : 30] Installing collected packages: pip
[2022-09-14 09:37:44,309][sh.py : 30] Attempting uninstall: pip
[2022-09-14 09:37:44,309][sh.py : 30] Found existing installation: pip 22.0.4
[2022-09-14 09:37:44,309][sh.py : 30] Uninstalling pip-22.0.4:
[2022-09-14 09:37:44,309][sh.py : 30] Successfully uninstalled pip-22.0.4
[2022-09-14 09:37:44,309][sh.py : 30] Successfully installed pip-22.2.2
[2022-09-14 09:37:44,309][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:37:44,309][sh.py : 30] Removing intermediate container 352c7d210047
[2022-09-14 09:37:44,309][sh.py : 30] ---> 89b9e36f60df
[2022-09-14 09:37:44,309][sh.py : 30] Step 5/9 : RUN pip install pipenv poetry
[2022-09-14 09:37:44,309][sh.py : 30] ---> Running in 32404f48999a
[2022-09-14 09:37:44,309][sh.py : 30] Collecting pipenv
[2022-09-14 09:37:44,309][sh.py : 30] Downloading pipenv-2022.9.8-py2.py3-none-any.whl (3.3 MB)
[2022-09-14 09:37:44,309][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.3/3.3 MB 93.3 MB/s eta 0:00:00
[2022-09-14 09:37:44,309][sh.py : 30] Collecting poetry
[2022-09-14 09:37:44,309][sh.py : 30] Downloading poetry-1.2.0-py3-none-any.whl (210 kB)
[2022-09-14 09:37:44,309][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 210.9/210.9 kB 39.9 MB/s eta 0:00:00
[2022-09-14 09:37:44,309][sh.py : 30] Collecting certifi
[2022-09-14 09:37:44,309][sh.py : 30] Downloading certifi-2022.6.15.2-py3-none-any.whl (160 kB)
[2022-09-14 09:37:44,309][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.4/160.4 kB 37.6 MB/s eta 0:00:00
[2022-09-14 09:37:45,599][sh.py : 30] Requirement already satisfied: setuptools>=36.2.1 in /var/lang/lib/python3.7/site-packages (from pipenv) (47.1.0)
[2022-09-14 09:37:45,599][sh.py : 30] Collecting virtualenv-clone>=0.2.5
[2022-09-14 09:37:45,599][sh.py : 30] Downloading virtualenv_clone-0.5.7-py3-none-any.whl (6.6 kB)
[2022-09-14 09:37:45,599][sh.py : 30] Collecting virtualenv
[2022-09-14 09:37:45,599][sh.py : 30] Downloading virtualenv-20.16.5-py3-none-any.whl (8.8 MB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 8.8/8.8 MB 108.4 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting html5lib<2.0,>=1.0
[2022-09-14 09:37:45,600][sh.py : 30] Downloading html5lib-1.1-py2.py3-none-any.whl (112 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 112.2/112.2 kB 29.9 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting tomlkit!=0.11.2,!=0.11.3,<1.0.0,>=0.11.1
[2022-09-14 09:37:45,600][sh.py : 30] Downloading tomlkit-0.11.4-py3-none-any.whl (35 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting cachy<0.4.0,>=0.3.0
[2022-09-14 09:37:45,600][sh.py : 30] Downloading cachy-0.3.0-py2.py3-none-any.whl (20 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting pkginfo<2.0,>=1.5
[2022-09-14 09:37:45,600][sh.py : 30] Downloading pkginfo-1.8.3-py2.py3-none-any.whl (26 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting requests<3.0,>=2.18
[2022-09-14 09:37:45,600][sh.py : 30] Downloading requests-2.28.1-py3-none-any.whl (62 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.8/62.8 kB 18.8 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting platformdirs<3.0.0,>=2.5.2
[2022-09-14 09:37:45,600][sh.py : 30] Downloading platformdirs-2.5.2-py3-none-any.whl (14 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting urllib3<2.0.0,>=1.26.0
[2022-09-14 09:37:45,600][sh.py : 30] Downloading urllib3-1.26.12-py2.py3-none-any.whl (140 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 140.4/140.4 kB 32.1 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting pexpect<5.0.0,>=4.7.0
[2022-09-14 09:37:45,600][sh.py : 30] Downloading pexpect-4.8.0-py2.py3-none-any.whl (59 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 59.0/59.0 kB 15.2 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting poetry-plugin-export<2.0.0,>=1.0.6
[2022-09-14 09:37:45,600][sh.py : 30] Downloading poetry_plugin_export-1.0.6-py3-none-any.whl (9.6 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting dulwich<0.21.0,>=0.20.44
[2022-09-14 09:37:45,600][sh.py : 30] Downloading dulwich-0.20.46-cp37-cp37m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (495 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 495.9/495.9 kB 68.2 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting packaging>=20.4
[2022-09-14 09:37:45,600][sh.py : 30] Downloading packaging-21.3-py3-none-any.whl (40 kB)
[2022-09-14 09:37:45,600][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 40.8/40.8 kB 12.0 MB/s eta 0:00:00
[2022-09-14 09:37:45,600][sh.py : 30] Collecting shellingham<2.0,>=1.5
[2022-09-14 09:37:45,600][sh.py : 30] Downloading shellingham-1.5.0-py2.py3-none-any.whl (9.3 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting cachecontrol[filecache]<0.13.0,>=0.12.9
[2022-09-14 09:37:45,600][sh.py : 30] Downloading CacheControl-0.12.11-py2.py3-none-any.whl (21 kB)
[2022-09-14 09:37:45,600][sh.py : 30] Collecting poetry-core==1.1.0
[2022-09-14 09:37:45,600][sh.py : 30] Downloading poetry_core-1.1.0-py3-none-any.whl (526 kB)
[2022-09-14 09:37:45,601][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 526.2/526.2 kB 80.5 MB/s eta 0:00:00
[2022-09-14 09:37:45,601][sh.py : 30] Collecting keyring>=21.2.0
[2022-09-14 09:37:45,601][sh.py : 30] Downloading keyring-23.9.1-py3-none-any.whl (35 kB)
[2022-09-14 09:37:45,601][sh.py : 30] Collecting cleo<2.0.0,>=1.0.0a5
[2022-09-14 09:37:45,601][sh.py : 30] Downloading cleo-1.0.0a5-py3-none-any.whl (78 kB)
[2022-09-14 09:37:45,601][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 78.7/78.7 kB 23.8 MB/s eta 0:00:00
[2022-09-14 09:37:45,601][sh.py : 30] Collecting requests-toolbelt<0.10.0,>=0.9.1
[2022-09-14 09:37:45,601][sh.py : 30] Downloading requests_toolbelt-0.9.1-py2.py3-none-any.whl (54 kB)
[2022-09-14 09:37:45,601][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 54.3/54.3 kB 17.3 MB/s eta 0:00:00
[2022-09-14 09:37:45,601][sh.py : 30] Collecting crashtest<0.4.0,>=0.3.0
[2022-09-14 09:37:45,601][sh.py : 30] Downloading crashtest-0.3.1-py3-none-any.whl (7.0 kB)
[2022-09-14 09:37:45,601][sh.py : 30] Collecting jsonschema<5.0.0,>=4.10.0
[2022-09-14 09:37:45,601][sh.py : 30] Downloading jsonschema-4.16.0-py3-none-any.whl (83 kB)
[2022-09-14 09:37:45,601][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 83.1/83.1 kB 23.9 MB/s eta 0:00:00
[2022-09-14 09:37:45,601][sh.py : 30] Collecting importlib-metadata<5.0,>=4.4
[2022-09-14 09:37:45,601][sh.py : 30] Downloading importlib_metadata-4.12.0-py3-none-any.whl (21 kB)
[2022-09-14 09:37:45,601][sh.py : 30] Collecting msgpack>=0.5.2
[2022-09-14 09:37:45,601][sh.py : 30] Downloading msgpack-1.0.4-cp37-cp37m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (299 kB)
[2022-09-14 09:37:47,829][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 299.8/299.8 kB 58.3 MB/s eta 0:00:00
[2022-09-14 09:37:47,829][sh.py : 30] Collecting lockfile>=0.9
[2022-09-14 09:37:47,829][sh.py : 30] Downloading lockfile-0.12.2-py2.py3-none-any.whl (13 kB)
[2022-09-14 09:37:47,829][sh.py : 30] Collecting pylev<2.0.0,>=1.3.0
[2022-09-14 09:37:47,829][sh.py : 30] Downloading pylev-1.4.0-py2.py3-none-any.whl (6.1 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting six>=1.9
[2022-09-14 09:37:47,830][sh.py : 30] Downloading six-1.16.0-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting webencodings
[2022-09-14 09:37:47,830][sh.py : 30] Downloading webencodings-0.5.1-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting zipp>=0.5
[2022-09-14 09:37:47,830][sh.py : 30] Downloading zipp-3.8.1-py3-none-any.whl (5.6 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting typing-extensions>=3.6.4
[2022-09-14 09:37:47,830][sh.py : 30] Downloading typing_extensions-4.3.0-py3-none-any.whl (25 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting importlib-resources>=1.4.0
[2022-09-14 09:37:47,830][sh.py : 30] Downloading importlib_resources-5.9.0-py3-none-any.whl (33 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting pkgutil-resolve-name>=1.3.10
[2022-09-14 09:37:47,830][sh.py : 30] Downloading pkgutil_resolve_name-1.3.10-py3-none-any.whl (4.7 kB)
[2022-09-14 09:37:47,830][sh.py : 30] Collecting attrs>=17.4.0
[2022-09-14 09:37:47,830][sh.py : 30] Downloading attrs-22.1.0-py2.py3-none-any.whl (58 kB)
[2022-09-14 09:37:47,830][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.8/58.8 kB 18.9 MB/s eta 0:00:00
[2022-09-14 09:37:47,830][sh.py : 30] Collecting pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0
[2022-09-14 09:37:47,830][sh.py : 30] Downloading pyrsistent-0.18.1-cp37-cp37m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (117 kB)
[2022-09-14 09:37:47,830][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 117.1/117.1 kB 32.1 MB/s eta 0:00:00
[2022-09-14 09:37:47,830][sh.py : 30] Collecting jeepney>=0.4.2
[2022-09-14 09:37:47,830][sh.py : 30] Downloading jeepney-0.8.0-py3-none-any.whl (48 kB)
[2022-09-14 09:37:47,831][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.4/48.4 kB 14.2 MB/s eta 0:00:00
[2022-09-14 09:37:47,831][sh.py : 30] Collecting jaraco.classes
[2022-09-14 09:37:47,831][sh.py : 30] Downloading jaraco.classes-3.2.2-py3-none-any.whl (6.0 kB)
[2022-09-14 09:37:47,831][sh.py : 30] Collecting SecretStorage>=3.2
[2022-09-14 09:37:47,831][sh.py : 30] Downloading SecretStorage-3.3.3-py3-none-any.whl (15 kB)
[2022-09-14 09:37:47,831][sh.py : 30] Collecting pyparsing!=3.0.5,>=2.0.2
[2022-09-14 09:37:47,831][sh.py : 30] Downloading pyparsing-3.0.9-py3-none-any.whl (98 kB)
[2022-09-14 09:37:47,831][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.3/98.3 kB 27.1 MB/s eta 0:00:00
[2022-09-14 09:37:47,831][sh.py : 30] Collecting ptyprocess>=0.5
[2022-09-14 09:37:47,831][sh.py : 30] Downloading ptyprocess-0.7.0-py2.py3-none-any.whl (13 kB)
[2022-09-14 09:37:47,831][sh.py : 30] Collecting charset-normalizer<3,>=2
[2022-09-14 09:37:47,831][sh.py : 30] Downloading charset_normalizer-2.1.1-py3-none-any.whl (39 kB)
[2022-09-14 09:37:47,831][sh.py : 30] Collecting idna<4,>=2.5
[2022-09-14 09:37:47,831][sh.py : 30] Downloading idna-3.4-py3-none-any.whl (61 kB)
[2022-09-14 09:37:47,831][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 61.5/61.5 kB 16.8 MB/s eta 0:00:00
[2022-09-14 09:37:47,831][sh.py : 30] Collecting filelock<4,>=3.4.1
[2022-09-14 09:37:47,831][sh.py : 30] Downloading filelock-3.8.0-py3-none-any.whl (10 kB)
[2022-09-14 09:37:47,831][sh.py : 30] Collecting distlib<1,>=0.3.5
[2022-09-14 09:37:47,831][sh.py : 30] Downloading distlib-0.3.6-py2.py3-none-any.whl (468 kB)
[2022-09-14 09:37:47,832][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 468.5/468.5 kB 77.2 MB/s eta 0:00:00
[2022-09-14 09:37:47,832][sh.py : 30] Collecting cryptography>=2.0
[2022-09-14 09:37:47,832][sh.py : 30] Downloading cryptography-38.0.1-cp36-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (4.1 MB)
[2022-09-14 09:37:47,832][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.1/4.1 MB 110.0 MB/s eta 0:00:00
[2022-09-14 09:37:47,832][sh.py : 30] Collecting more-itertools
[2022-09-14 09:37:47,832][sh.py : 30] Downloading more_itertools-8.14.0-py3-none-any.whl (52 kB)
[2022-09-14 09:37:47,832][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 52.2/52.2 kB 15.6 MB/s eta 0:00:00
[2022-09-14 09:37:47,832][sh.py : 30] Collecting cffi>=1.12
[2022-09-14 09:37:47,832][sh.py : 30] Downloading cffi-1.15.1-cp37-cp37m-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (427 kB)
[2022-09-14 09:37:47,832][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 427.9/427.9 kB 54.2 MB/s eta 0:00:00
[2022-09-14 09:37:47,832][sh.py : 30] Collecting pycparser
[2022-09-14 09:37:47,832][sh.py : 30] Downloading pycparser-2.21-py2.py3-none-any.whl (118 kB)
[2022-09-14 09:37:47,832][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.7/118.7 kB 33.6 MB/s eta 0:00:00
time="2022-09-14T09:37:51.830749906Z" level=info msg="ignoring event" container=32404f48999a94ffffa65345b221f1b7c6369d13b61e6dfb120fc2a6543d9bae module=libcontainerd namespace=moby topic=/tasks/delete type="events.TaskDelete"
time="2022-09-14T09:37:51.831514129Z" level=info msg="shim disconnected" id=32404f48999a94ffffa65345b221f1b7c6369d13b61e6dfb120fc2a6543d9bae
time="2022-09-14T09:37:51.831574558Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:37:54.395055711Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/18da9448540b251215bdcaece2b828177dd4657177ed0b19b2a1e18db1b39ecc pid=1518
[2022-09-14 09:37:56,173][sh.py : 30] Installing collected packages: webencodings, pylev, ptyprocess, msgpack, lockfile, distlib, zipp, virtualenv-clone, urllib3, typing-extensions, tomlkit, six, shellingham, pyrsistent, pyparsing, pycparser, platformdirs, pkgutil-resolve-name, pkginfo, pexpect, more-itertools, jeepney, idna, filelock, crashtest, charset-normalizer, certifi, cachy, attrs, requests, packaging, jaraco.classes, importlib-resources, importlib-metadata, html5lib, dulwich, cleo, cffi, virtualenv, requests-toolbelt, poetry-core, jsonschema, cryptography, cachecontrol, SecretStorage, pipenv, keyring, poetry-plugin-export, poetry
[2022-09-14 09:37:56,173][sh.py : 30] Successfully installed SecretStorage-3.3.3 attrs-22.1.0 cachecontrol-0.12.11 cachy-0.3.0 certifi-2022.6.15.2 cffi-1.15.1 charset-normalizer-2.1.1 cleo-1.0.0a5 crashtest-0.3.1 cryptography-38.0.1 distlib-0.3.6 dulwich-0.20.46 filelock-3.8.0 html5lib-1.1 idna-3.4 importlib-metadata-4.12.0 importlib-resources-5.9.0 jaraco.classes-3.2.2 jeepney-0.8.0 jsonschema-4.16.0 keyring-23.9.1 lockfile-0.12.2 more-itertools-8.14.0 msgpack-1.0.4 packaging-21.3 pexpect-4.8.0 pipenv-2022.9.8 pkginfo-1.8.3 pkgutil-resolve-name-1.3.10 platformdirs-2.5.2 poetry-1.2.0 poetry-core-1.1.0 poetry-plugin-export-1.0.6 ptyprocess-0.7.0 pycparser-2.21 pylev-1.4.0 pyparsing-3.0.9 pyrsistent-0.18.1 requests-2.28.1 requests-toolbelt-0.9.1 shellingham-1.5.0 six-1.16.0 tomlkit-0.11.4 typing-extensions-4.3.0 urllib3-1.26.12 virtualenv-20.16.5 virtualenv-clone-0.5.7 webencodings-0.5.1 zipp-3.8.1
[2022-09-14 09:37:56,173][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:37:56,173][sh.py : 30] Removing intermediate container 32404f48999a
[2022-09-14 09:37:56,173][sh.py : 30] ---> 1e774397a40e
[2022-09-14 09:37:56,173][sh.py : 30] Step 6/9 : WORKDIR /var/dependencies
[2022-09-14 09:37:56,173][sh.py : 30] ---> Running in 483aa5e2bf8f
[2022-09-14 09:37:56,173][sh.py : 30] Removing intermediate container 483aa5e2bf8f
[2022-09-14 09:37:56,173][sh.py : 30] ---> 4f37fe5841b8
[2022-09-14 09:37:56,173][sh.py : 30] Step 7/9 : COPY Pipfile pyproject* poetry* requirements.tx[t] ./
[2022-09-14 09:37:56,173][sh.py : 30] ---> 16d5cd62aa8d
[2022-09-14 09:37:56,173][sh.py : 30] Step 8/9 : RUN [ -f 'Pipfile' ] && pipenv lock -r >requirements.txt; [ -f 'poetry.lock' ] && poetry export --with-credentials --format requirements.txt --output requirements.txt; [ -f 'requirements.txt' ] && pip install -r requirements.txt -t .;
[2022-09-14 09:37:56,173][sh.py : 30] ---> Running in 18da9448540b
[2022-09-14 09:37:56,173][sh.py : 30] Collecting kubernetes==12.0.1
[2022-09-14 09:37:56,173][sh.py : 30] Downloading kubernetes-12.0.1-py2.py3-none-any.whl (1.7 MB)
[2022-09-14 09:37:56,173][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.7/1.7 MB 58.2 MB/s eta 0:00:00
[2022-09-14 09:37:56,173][sh.py : 30] Collecting python-dateutil>=2.5.3
[2022-09-14 09:37:56,173][sh.py : 30] Downloading python_dateutil-2.8.2-py2.py3-none-any.whl (247 kB)
[2022-09-14 09:37:56,173][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 247.7/247.7 kB 39.0 MB/s eta 0:00:00
[2022-09-14 09:37:56,173][sh.py : 30] Collecting websocket-client!=0.40.0,!=0.41.,!=0.42.,>=0.32.0
[2022-09-14 09:37:56,174][sh.py : 30] Downloading websocket_client-1.4.1-py3-none-any.whl (55 kB)
[2022-09-14 09:37:56,174][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 55.0/55.0 kB 11.6 MB/s eta 0:00:00
[2022-09-14 09:37:56,174][sh.py : 30] Collecting certifi>=14.05.14
[2022-09-14 09:37:56,174][sh.py : 30] Using cached certifi-2022.6.15.2-py3-none-any.whl (160 kB)
[2022-09-14 09:37:56,174][sh.py : 30] Collecting google-auth>=1.0.1
[2022-09-14 09:37:56,174][sh.py : 30] Downloading google_auth-2.11.0-py2.py3-none-any.whl (167 kB)
[2022-09-14 09:37:56,174][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 167.2/167.2 kB 42.1 MB/s eta 0:00:00
[2022-09-14 09:37:56,174][sh.py : 30] Collecting requests-oauthlib
[2022-09-14 09:37:56,174][sh.py : 30] Downloading requests_oauthlib-1.3.1-py2.py3-none-any.whl (23 kB)
[2022-09-14 09:37:56,174][sh.py : 30] Collecting urllib3>=1.24.2
[2022-09-14 09:37:56,174][sh.py : 30] Using cached urllib3-1.26.12-py2.py3-none-any.whl (140 kB)
[2022-09-14 09:37:56,174][sh.py : 30] Collecting pyyaml>=3.12
[2022-09-14 09:37:56,174][sh.py : 30] Downloading PyYAML-6.0-cp37-cp37m-manylinux_2_5_x86_64.manylinux1_x86_64.manylinux_2_12_x86_64.manylinux2010_x86_64.whl (596 kB)
[2022-09-14 09:37:56,174][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 596.3/596.3 kB 69.4 MB/s eta 0:00:00
[2022-09-14 09:37:56,174][sh.py : 30] Collecting setuptools>=21.0.0
[2022-09-14 09:37:56,174][sh.py : 30] Using cached setuptools-65.3.0-py3-none-any.whl (1.2 MB)
[2022-09-14 09:37:56,174][sh.py : 30] Collecting six>=1.9.0
[2022-09-14 09:37:56,174][sh.py : 30] Using cached six-1.16.0-py2.py3-none-any.whl (11 kB)
[2022-09-14 09:37:56,174][sh.py : 30] Collecting requests
time="2022-09-14T09:37:59.635216065Z" level=info msg="ignoring event" container=18da9448540b251215bdcaece2b828177dd4657177ed0b19b2a1e18db1b39ecc module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:37:59.635901099Z" level=info msg="shim disconnected" id=18da9448540b251215bdcaece2b828177dd4657177ed0b19b2a1e18db1b39ecc
time="2022-09-14T09:37:59.635964992Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
time="2022-09-14T09:38:01.034860106Z" level=info msg="Layer sha256:0875412c69ef01af31a3e4ef634545d0236d692a0741a792e43ae1a21fec6c33 cleaned up"
time="2022-09-14T09:38:01.192379674Z" level=info msg="starting signal loop" namespace=moby path=/run/docker/containerd/daemon/io.containerd.runtime.v2.task/moby/21b6c5bc9bdb5c50d67a597523797db54f9ee341adf2dd69f6ce16c95b6d30df pid=1616
time="2022-09-14T09:38:02.178105554Z" level=info msg="ignoring event" container=21b6c5bc9bdb5c50d67a597523797db54f9ee341adf2dd69f6ce16c95b6d30df module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
time="2022-09-14T09:38:02.178680695Z" level=info msg="shim disconnected" id=21b6c5bc9bdb5c50d67a597523797db54f9ee341adf2dd69f6ce16c95b6d30df
time="2022-09-14T09:38:02.178732037Z" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
[2022-09-14 09:38:02,786][sh.py : 30] Using cached requests-2.28.1-py3-none-any.whl (62 kB)
[2022-09-14 09:38:02,786][sh.py : 30] Collecting cachetools<6.0,>=2.0.0
[2022-09-14 09:38:02,786][sh.py : 30] Downloading cachetools-5.2.0-py3-none-any.whl (9.3 kB)
[2022-09-14 09:38:02,786][sh.py : 30] Collecting pyasn1-modules>=0.2.1
[2022-09-14 09:38:02,786][sh.py : 30] Downloading pyasn1_modules-0.2.8-py2.py3-none-any.whl (155 kB)
[2022-09-14 09:38:02,786][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 155.3/155.3 kB 29.3 MB/s eta 0:00:00
[2022-09-14 09:38:02,786][sh.py : 30] Collecting rsa<5,>=3.1.4
[2022-09-14 09:38:02,786][sh.py : 30] Downloading rsa-4.9-py3-none-any.whl (34 kB)
[2022-09-14 09:38:02,786][sh.py : 30] Collecting idna<4,>=2.5
[2022-09-14 09:38:02,786][sh.py : 30] Using cached idna-3.4-py3-none-any.whl (61 kB)
[2022-09-14 09:38:02,786][sh.py : 30] Collecting charset-normalizer<3,>=2
[2022-09-14 09:38:02,786][sh.py : 30] Using cached charset_normalizer-2.1.1-py3-none-any.whl (39 kB)
[2022-09-14 09:38:02,786][sh.py : 30] Collecting oauthlib>=3.0.0
[2022-09-14 09:38:02,786][sh.py : 30] Downloading oauthlib-3.2.1-py3-none-any.whl (151 kB)
[2022-09-14 09:38:02,786][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 151.7/151.7 kB 35.6 MB/s eta 0:00:00
[2022-09-14 09:38:02,786][sh.py : 30] Collecting pyasn1<0.5.0,>=0.4.6
[2022-09-14 09:38:02,786][sh.py : 30] Downloading pyasn1-0.4.8-py2.py3-none-any.whl (77 kB)
[2022-09-14 09:38:02,786][sh.py : 30] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 77.1/77.1 kB 22.0 MB/s eta 0:00:00
[2022-09-14 09:38:02,786][sh.py : 30] Installing collected packages: pyasn1, websocket-client, urllib3, six, setuptools, rsa, pyyaml, pyasn1-modules, oauthlib, idna, charset-normalizer, certifi, cachetools, requests, python-dateutil, google-auth, requests-oauthlib, kubernetes
[2022-09-14 09:38:02,786][sh.py : 30] Successfully installed cachetools-5.2.0 certifi-2022.6.15.2 charset-normalizer-2.1.1 google-auth-2.11.0 idna-3.4 kubernetes-12.0.1 oauthlib-3.2.1 pyasn1-0.4.8 pyasn1-modules-0.2.8 python-dateutil-2.8.2 pyyaml-6.0 requests-2.28.1 requests-oauthlib-1.3.1 rsa-4.9 setuptools-65.3.0 six-1.16.0 urllib3-1.26.12 websocket-client-1.4.1
[2022-09-14 09:38:02,786][sh.py : 30] WARNING: Running pip as the 'root' user can result in broken permissions and conflicting behaviour with the system package manager. It is recommended to use a virtual environment instead: https://pip.pypa.io/warnings/venv
[2022-09-14 09:38:02,786][sh.py : 30] Removing intermediate container 18da9448540b
[2022-09-14 09:38:02,786][sh.py : 30] ---> 33520c310fb3
[2022-09-14 09:38:02,786][sh.py : 30] Step 9/9 : CMD [ "python" ]
[2022-09-14 09:38:02,786][sh.py : 30] ---> Running in fbef00cd87a3
[2022-09-14 09:38:02,787][sh.py : 30] Removing intermediate container fbef00cd87a3
[2022-09-14 09:38:02,787][sh.py : 30] ---> b2c35694f13f
[2022-09-14 09:38:02,787][sh.py : 30] Successfully built b2c35694f13f
[2022-09-14 09:38:02,787][sh.py : 30] Successfully tagged cdk-d806bb9841f601d15ea7c752ad2fcc4ea2d1ba759dd656dd0901ca1e7b3edb14:latest
[2022-09-14 09:38:02,787][sh.py : 30] Bundling asset orbit-orbit/cognito_post_authentication_lambda/Code/Stage...
[2022-09-14 09:38:02,787][sh.py : 30] Sending build context to Docker daemon 3.584kB

[2022-09-14 09:38:02,787][sh.py : 30] Step 1/9 : ARG IMAGE=public.ecr.aws/sam/build-python3.7
[2022-09-14 09:38:02,787][sh.py : 30] Step 2/9 : FROM $IMAGE
[2022-09-14 09:38:02,787][sh.py : 30] ---> 8b7735bbc14b
[2022-09-14 09:38:02,787][sh.py : 30] Step 3/9 : RUN yum -q list installed rsync &>/dev/null || yum install -y rsync
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 94541a718b94
[2022-09-14 09:38:02,787][sh.py : 30] Step 4/9 : RUN pip install --upgrade pip
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 89b9e36f60df
[2022-09-14 09:38:02,787][sh.py : 30] Step 5/9 : RUN pip install pipenv poetry
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 1e774397a40e
[2022-09-14 09:38:02,787][sh.py : 30] Step 6/9 : WORKDIR /var/dependencies
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 4f37fe5841b8
[2022-09-14 09:38:02,787][sh.py : 30] Step 7/9 : COPY Pipfile* pyproject* poetry* requirements.tx[t] ./
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 16d5cd62aa8d
[2022-09-14 09:38:02,787][sh.py : 30] Step 8/9 : RUN [ -f 'Pipfile' ] && pipenv lock -r >requirements.txt; [ -f 'poetry.lock' ] && poetry export --with-credentials --format requirements.txt --output requirements.txt; [ -f 'requirements.txt' ] && pip install -r requirements.txt -t .;
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> 33520c310fb3
[2022-09-14 09:38:02,787][sh.py : 30] Step 9/9 : CMD [ "python" ]
[2022-09-14 09:38:02,787][sh.py : 30] ---> Using cache
[2022-09-14 09:38:02,787][sh.py : 30] ---> b2c35694f13f
[2022-09-14 09:38:02,787][sh.py : 30] Successfully built b2c35694f13f
[2022-09-14 09:38:02,787][sh.py : 30] Successfully tagged cdk-4eb56de43d5ceaf623deb9b1fe6ae9465713568602d73d3ee0074f6f07278758:latest
[2022-09-14 09:38:03,153][sh.py : 30] orbit-orbit: deploying...
[2022-09-14 09:38:03,160][sh.py : 30] Waiting for stack CDKToolkit to finish creating or updating...
[2022-09-14 09:38:03,247][sh.py : 30] [AWS cloudformation 400 0.086s 0 retries] describeStacks({ StackName: 'CDKToolkit' })
[2022-09-14 09:38:03,247][sh.py : 30] Call failed: describeStacks({"StackName":"CDKToolkit"}) => Stack with id CDKToolkit does not exist (code=ValidationError)
[2022-09-14 09:38:03,248][sh.py : 30] Stack CDKToolkit does not exist
[2022-09-14 09:38:03,248][sh.py : 30] The environment aws://552000000073/eu-central-1 doesn't have the CDK toolkit stack (CDKToolkit) installed. Use cdk bootstrap "aws://552000000073/eu-central-1" to setup your environment for use with the toolkit.
[2022-09-14 09:38:03,357][sh.py : 30] [AWS cloudformation 400 0.108s 0 retries] describeStacks({ StackName: 'orbit-orbit' })
[2022-09-14 09:38:03,357][sh.py : 30] Call failed: describeStacks({"StackName":"orbit-orbit"}) => Stack with id orbit-orbit does not exist (code=ValidationError)
[2022-09-14 09:38:03,403][sh.py : 30]
[2022-09-14 09:38:03,404][sh.py : 30] ❌ orbit-orbit failed: Error: This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://552000000073/eu-central-1")
[2022-09-14 09:38:03,404][sh.py : 30] at Object.addMetadataAssetsToManifest (/usr/lib/node_modules/aws-cdk/lib/assets.ts:27:11)
[2022-09-14 09:38:03,404][sh.py : 30] at Object.deployStack (/usr/lib/node_modules/aws-cdk/lib/api/deploy-stack.ts:211:29)
[2022-09-14 09:38:03,404][sh.py : 30] at processTicksAndRejections (internal/process/task_queues.js:97:5)
[2022-09-14 09:38:03,404][sh.py : 30] at CdkToolkit.deploy (/usr/lib/node_modules/aws-cdk/lib/cdk-toolkit.ts:180:24)
[2022-09-14 09:38:03,404][sh.py : 30] at initCommandLine (/usr/lib/node_modules/aws-cdk/bin/cdk.ts:208:9)
[2022-09-14 09:38:03,404][sh.py : 30] This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://552000000073/eu-central-1")
[2022-09-14 09:38:03,404][sh.py : 30] Error: This stack uses assets, so the toolkit stack must be deployed to the environment (Run "cdk bootstrap aws://552000000073/eu-central-1")
[2022-09-14 09:38:03,404][sh.py : 30] at Object.addMetadataAssetsToManifest (/usr/lib/node_modules/aws-cdk/lib/assets.ts:27:11)
[2022-09-14 09:38:03,404][sh.py : 30] at Object.deployStack (/usr/lib/node_modules/aws-cdk/lib/api/deploy-stack.ts:211:29)
[2022-09-14 09:38:03,404][sh.py : 30] at processTicksAndRejections (internal/process/task_queues.js:97:5)
[2022-09-14 09:38:03,404][sh.py : 30] at CdkToolkit.deploy (/usr/lib/node_modules/aws-cdk/lib/cdk-toolkit.ts:180:24)
[2022-09-14 09:38:03,404][sh.py : 30] at initCommandLine (/usr/lib/node_modules/aws-cdk/bin/cdk.ts:208:9)
[2022-09-14 09:38:03,410][sh.py : 30]
Traceback (most recent call last):
File "/root/.venv/bin/codeseeder", line 8, in
sys.exit(main())
File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/main.py", line 161, in main
cli()
File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 829, in call
return self.main(*args, **kwargs)
File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 782, in main
rv = self.invoke(ctx)
File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 1259, in invoke
return _process_result(sub_ctx.command.invoke(sub_ctx))
File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 1066, in invoke
return ctx.invoke(self.callback, **ctx.params)
File "/root/.venv/lib/python3.7/site-packages/click/core.py", line 610, in invoke
return callback(*args, **kwargs)
File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/main.py", line 153, in execute
func(*fn_args["args"], **fn_args["kwargs"])
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/deploy.py", line 398, in deploy_env
deploy_env(env_name=env_name, manifest_dir=manifest_dir)
File "/root/.venv/lib/python3.7/site-packages/aws_codeseeder/codeseeder.py", line 229, in wrapper
return func(*args, **kwargs)
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/deploy.py", line 376, in deploy_env
eks_system_masters_roles_changes=changeset.eks_system_masters_roles_changeset if changeset else None,
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/remote_files/env.py", line 80, in deploy
args=args,
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/cdk.py", line 49, in deploy
sh.run(cmd=cmd)
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/sh.py", line 29, in run
for line in _run_iterating(cmd=cmd, cwd=cwd):
File "/root/.venv/lib/python3.7/site-packages/aws_orbit/sh.py", line 23, in _run_iterating
raise FailedShellCommand(f"Exit code: {p.returncode}")
aws_orbit.exceptions.FailedShellCommand: Exit code: 1

[Container] 2022/09/14 09:38:03 Command did not exit successfully codeseeder execute --args-file fn_args.json --debug exit status 1
[Container] 2022/09/14 09:38:03 Phase complete: BUILD State: FAILED
[Container] 2022/09/14 09:38:03 Phase context status code: COMMAND_EXECUTION_ERROR Message: Error while executing command: codeseeder execute --args-file fn_args.json --debug. Reason: exit status 1
[Container] 2022/09/14 09:38:03 Entering phase POST_BUILD
[Container] 2022/09/14 09:38:03 Running command . ~/.venv/bin/activate

[Container] 2022/09/14 09:38:03 Running command cd ${CODEBUILD_SRC_DIR}/bundle

[Container] 2022/09/14 09:38:03 Phase complete: POST_BUILD State: SUCCEEDED
[Container] 2022/09/14 09:38:03 Phase context status code: Message:

from aws-orbit-workbench.

ok. i see one problem that we caused by trying to add debugging for your original problem. in the image there is no space between the --debug parameter and the --toolkit-stack-name parameter, i see:

-vvvvv --debug--toolkit-stack-name orbit-orbit-cdk-toolkit

i'm pretty certain this is causing the problem with the toolkit stack not being found. just need to go back to that cli/aws_orbit/cdk.py file and ensure there is a space after the --debug parameter.

this should get us back to your original problem which was the ACCESS_DENIED. hopefully with the added -vvvvv and --debug we'll have more info to figure that out.

from aws-orbit-workbench.

Hi @chamcca, Putting a space after debug helped. I see now that the stack tries to upload file into s3 bucket. The reason why it fails with access denied is because we are only allowed to upload to s3 if we pass server encryption option when uploading. Could you please help with identifying the file I need to update with Server Encryption option?

Below are some changes I made that got me started. before making this changes, I couldn't run even the toolkit stack
cli/aws_orbit/services/s3.py

LOGS

807d89.zip
[2022-09-16 09:08:30,591][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,217][sh.py : 30] orbit-orbit: checking if we can skip deploy
[2022-09-16 09:08:30,591][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,217][sh.py : 30] orbit-orbit: no existing stack
[2022-09-16 09:08:30,591][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,217][sh.py : 30] orbit-orbit: deploying...
[2022-09-16 09:08:30,591][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,241][sh.py : 30] [0%] start: Publishing bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25:current
[2022-09-16 09:08:30,591][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,250][sh.py : 30] [0%] check: Check s3://orbit-orbit-cdk-toolkit-352133749271-lreido/assets/bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25.zip
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,403][sh.py : 30] [AWS s3 200 0.153s 0 retries] getBucketLocation({ Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido' })
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,535][sh.py : 30] [AWS s3 200 0.132s 0 retries] listObjectsV2({
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,536][sh.py : 30] Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,536][sh.py : 30] Prefix: 'assets/bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25.zip',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,536][sh.py : 30] MaxKeys: 1
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,536][sh.py : 30] })
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:24,536][sh.py : 30] [0%] build: Zip /codebuild/output/src343788118/src/bundle/.orbit.out/orbit/cdk/orbit-orbit/asset.bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25 -> [object Object]
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,366][sh.py : 30] [0%] upload: Upload s3://orbit-orbit-cdk-toolkit-352133749271-lreido/assets/bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25.zip
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] [AWS s3 403 0.054s 0 retries] putObject({
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] Body: <Buffer 50 4b 03 04 14 00 08 00 08 00 00 00 21 00 00 00 00 00 00 00 00 00 00 00 00 00 0b 00 00 00 5f 5f 69 6e 69 74 5f 5f 2e 70 79 5d 52 cb 6e db 30 10 bc e7 ... 1656837 more bytes>,
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] Key: 'assets/bfa1f46d035e17a921b45e305aa6ba969a2216112b92e6c33f576c3d3ac2ed25.zip',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] ContentType: 'application/zip'
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] })
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] [33%] fail: Access Denied
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,426][sh.py : 30] [33%] start: Publishing d0a91ce4cd1c8c65657431d94a5571d6b756c595542d0ca50c1514619f008fae:current
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,427][sh.py : 30] [33%] check: Check s3://orbit-orbit-cdk-toolkit-352133749271-lreido/assets/d0a91ce4cd1c8c65657431d94a5571d6b756c595542d0ca50c1514619f008fae.zip
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,469][sh.py : 30] [AWS s3 200 0.042s 0 retries] getBucketLocation({ Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido' })
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,493][sh.py : 30] [AWS s3 200 0.024s 0 retries] listObjectsV2({
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,493][sh.py : 30] Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,493][sh.py : 30] Prefix: 'assets/d0a91ce4cd1c8c65657431d94a5571d6b756c595542d0ca50c1514619f008fae.zip',
[2022-09-16 09:08:30,592][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,494][sh.py : 30] MaxKeys: 1
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,494][sh.py : 30] })
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,494][sh.py : 30] [33%] build: Zip /codebuild/output/src343788118/src/bundle/.orbit.out/orbit/cdk/orbit-orbit/asset.d0a91ce4cd1c8c65657431d94a5571d6b756c595542d0ca50c1514619f008fae -> [object Object]
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,501][sh.py : 30] [33%] upload: Upload s3://orbit-orbit-cdk-toolkit-352133749271-lreido/assets/d0a91ce4cd1c8c65657431d94a5571d6b756c595542d0ca50c1514619f008fae.zip
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,547][sh.py : 30] [AWS s3 403 0.045s 0 retries] putObject({
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,547][sh.py : 30] Body: <Buffer 50 4b 03 04 14 00 08 00 08 00 00 00 21 00 00 00 00 00 00 00 00 00 00 00 00 00 0b 00 00 00 5f 5f 69 6e 69 74 5f 5f 2e 70 79 5d 52 cb 6e db 30 10 bc e7 ... 3170 more bytes>,
[2022-09-16 09:08:30,593][_remote.py : 30] [CODEBUILD] [2022-09-16 07:08:25,547][sh.py : 30] Bucket: 'orbit-orbit-cdk-toolkit-352133749271-lreido',

from aws-orbit-workbench.

Thank you @chamcca, That solved the problem with access denied on s3 upload.

from aws-orbit-workbench.

@chamcca I hope you will be able to advice on how I can fix below error. As I said, our account is highly hardened. this is banks requirement.

arn:aws:sts::00000000000:assumed-role/orbit-orbit-eu-central-1-admin/AWSCodeBuild-cc3021c7-8779-47c4-8c91-2e9b8a5f4a16 is not authorized to perform: serverlessrepo:CreateCloudFormationTemplate on resource: arn:aws:serverlessrepo:us-east-1:903779448426:applications/lambda-layer-kubectl with an explicit deny

from aws-orbit-workbench.