pulumi_us_west_2-try-2-log.txt

I0325 13:25:23.808125   46506 backend.go:727] Stack dev being updated to version 1
I0325 13:25:24.158532   46506 plugins.go:72] gatherPluginsFromProgram(): gathering plugins from language host
I0325 13:25:24.158694   46506 plugins.go:372] GetPluginPath(language, nodejs, <nil>): found on $PATH /usr/local/bin/pulumi-language-nodejs
I0325 13:25:24.287418   46506 langruntime_plugin.go:166] langhost[nodejs].GetPluginInfo() executing
I0325 13:25:24.288099   46506 langruntime_plugin.go:83] langhost[nodejs].GetRequiredPlugins(proj=eks-cluster,pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.) executing
I0325 13:25:24.456721   46506 langruntime_plugin.go:124] langhost[nodejs].GetRequiredPlugins(proj=eks-cluster,pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.) success: #versions=3
I0325 13:25:24.456769   46506 plugins.go:79] gatherPluginsFromProgram(): plugin nodejs <nil> is required by language host
I0325 13:25:24.456796   46506 plugins.go:79] gatherPluginsFromProgram(): plugin aws 0.17.1 is required by language host
I0325 13:25:24.456814   46506 plugins.go:79] gatherPluginsFromProgram(): plugin docker 0.17.0 is required by language host
I0325 13:25:24.456825   46506 plugins.go:79] gatherPluginsFromProgram(): plugin kubernetes 0.21.1 is required by language host
I0325 13:25:24.456840   46506 plugins.go:90] gatherPluginsFromSnapshot(): gathering plugins from snapshot
I0325 13:25:24.456862   46506 plugins.go:131] ensurePluginsAreInstalled(): beginning
I0325 13:25:24.457972   46506 plugins.go:411] GetPluginPath(resource, docker, 0.17.0): enabling new plugin behavior
I0325 13:25:24.457997   46506 plugins.go:492] SelectCompatiblePlugin(..., docker): beginning
I0325 13:25:24.458020   46506 plugins.go:525] SelectCompatiblePlugin(..., docker): skipping plugin docker-0.16.4: semver mismatch
I0325 13:25:24.458039   46506 plugins.go:521] SelectCompatiblePlugin(..., docker): best plugin docker-0.17.0: semver match
I0325 13:25:24.458051   46506 plugins.go:534] SelectCompatiblePlugin(..., docker): selecting plugin 'docker-0.17.0': best match 
I0325 13:25:24.458066   46506 plugins.go:458] GetPluginPath(resource, docker, 0.17.0): found in cache at /Users/ggilmore/.pulumi/plugins/resource-docker-v0.17.0/pulumi-resource-docker
I0325 13:25:24.458078   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin docker 0.17.0 already installed
I0325 13:25:24.458985   46506 plugins.go:411] GetPluginPath(resource, kubernetes, 0.21.1): enabling new plugin behavior
I0325 13:25:24.459003   46506 plugins.go:492] SelectCompatiblePlugin(..., kubernetes): beginning
I0325 13:25:24.459022   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.17.5: semver mismatch
I0325 13:25:24.459035   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.20.2: semver mismatch
I0325 13:25:24.459047   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.20.3: semver mismatch
I0325 13:25:24.459061   46506 plugins.go:521] SelectCompatiblePlugin(..., kubernetes): best plugin kubernetes-0.21.1: semver match
I0325 13:25:24.459072   46506 plugins.go:534] SelectCompatiblePlugin(..., kubernetes): selecting plugin 'kubernetes-0.21.1': best match 
I0325 13:25:24.459094   46506 plugins.go:458] GetPluginPath(resource, kubernetes, 0.21.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-kubernetes-v0.21.1/pulumi-resource-kubernetes
I0325 13:25:24.459106   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin kubernetes 0.21.1 already installed
I0325 13:25:24.459149   46506 plugins.go:372] GetPluginPath(language, nodejs, <nil>): found on $PATH /usr/local/bin/pulumi-language-nodejs
I0325 13:25:24.459170   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin nodejs <nil> already installed
I0325 13:25:24.460139   46506 plugins.go:411] GetPluginPath(resource, aws, 0.17.1): enabling new plugin behavior
I0325 13:25:24.460167   46506 plugins.go:492] SelectCompatiblePlugin(..., aws): beginning
I0325 13:25:24.460185   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.15.1: semver mismatch
I0325 13:25:24.460227   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.8: semver mismatch
I0325 13:25:24.460238   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.10: semver mismatch
I0325 13:25:24.460247   46506 plugins.go:521] SelectCompatiblePlugin(..., aws): best plugin aws-0.17.1: semver match
I0325 13:25:24.460256   46506 plugins.go:534] SelectCompatiblePlugin(..., aws): selecting plugin 'aws-0.17.1': best match 
I0325 13:25:24.460268   46506 plugins.go:458] GetPluginPath(resource, aws, 0.17.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-aws-v0.17.1/pulumi-resource-aws
I0325 13:25:24.460277   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin aws 0.17.1 already installed
I0325 13:25:24.460285   46506 plugins.go:151] ensurePluginsAreInstalled(): completed
I0325 13:25:24.460603   46506 step_generator.go:470] stepGenerator.GeneratePendingDeletes(): scanning previous snapshot for pending deletes
I0325 13:25:24.460651   46506 langruntime_plugin.go:134] langhost[nodejs].Run(pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.,#args=0,proj=eks-cluster,stack=dev,#config=1,dryrun=true) executing
I0325 13:25:24.460666   46506 plan_executor.go:237] planExecutor.retirePendingDeletes(...): no pending deletions
I0325 13:25:24.460774   46506 plan_executor.go:137] planExecutor.Execute(...): waiting for incoming events
I0325 13:25:24.460896   46506 step_executor.go:310] StepExecutor worker(-2): worker coming online
I0325 13:25:24.460916   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:25.448309   46506 eventsink.go:60] Registering resource: t=pulumi:pulumi:Stack, name=eks-cluster-dev, custom=false
I0325 13:25:25.456283   46506 eventsink.go:60] RegisterResource RPC prepared: t=pulumi:pulumi:Stack, name=eks-cluster-dev
I0325 13:25:25.456612   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=pulumi:pulumi:Stack, name=eks-cluster-dev, custom=false, #props=0, parent=, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:25.456656   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=pulumi:pulumi:Stack,name=eks-cluster-dev,#props=0
I0325 13:25:25.456675   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:25.456687   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:25.456759   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev' (inputs=map[])
I0325 13:25:25.456794   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:25.456811   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:25.456847   46506 step_executor.go:310] StepExecutor worker(0): launching oneshot worker
I0325 13:25:25.456910   46506 step_executor.go:310] StepExecutor worker(0): applying step create on urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev (preview true)
I0325 13:25:25.456944   46506 step_executor.go:310] StepExecutor worker(0): step create on urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev retired
I0325 13:25:25.457005   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=pulumi:pulumi:Stack, urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, stable=false, #stables=0 #outs=0
I0325 13:25:25.463946   46506 eventsink.go:60] RegisterResource RPC finished: resource:eks-cluster-dev[pulumi:pulumi:Stack]; err: null, resp: urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev,,,,
I0325 13:25:26.447967   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:26.448032   46506 source_eval.go:291] waiting for default provider for package aws
I0325 13:25:26.448057   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=pulumi:providers:aws,name=default,#props=2
I0325 13:25:26.448068   46506 eventsink.go:60] Running program '/Users/ggilmore/dev/scripts/pulumi-eip-repro' in pwd '/Users/ggilmore/dev/scripts/pulumi-eip-repro' w/ args: 
I0325 13:25:26.448168   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:26.448218   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:26.448248   46506 registry.go:218] ProviderRegistry.Check(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default) executing (#olds=0,#news=2
I0325 13:25:26.450183   46506 plugins.go:411] GetPluginPath(resource, aws, 0.17.1): enabling new plugin behavior
I0325 13:25:26.450221   46506 plugins.go:492] SelectCompatiblePlugin(..., aws): beginning
I0325 13:25:26.450237   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.15.1: semver mismatch
I0325 13:25:26.450248   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.8: semver mismatch
I0325 13:25:26.450259   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.10: semver mismatch
I0325 13:25:26.450268   46506 plugins.go:521] SelectCompatiblePlugin(..., aws): best plugin aws-0.17.1: semver match
I0325 13:25:26.450277   46506 plugins.go:534] SelectCompatiblePlugin(..., aws): selecting plugin 'aws-0.17.1': best match 
I0325 13:25:26.450290   46506 plugins.go:458] GetPluginPath(resource, aws, 0.17.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-aws-v0.17.1/pulumi-resource-aws
I0325 13:25:26.456218   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Vpc, name=eksNetwork, custom=false
I0325 13:25:26.456351   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:NatGateway, name=eksNetwork-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.456552   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:NatGateway,name=eksNetwork-0,#props=0
I0325 13:25:26.456608   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:NatGateway, name=eksNetwork-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.456777   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Vpc, name=eksNetwork, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.458395   46506 eventsink.go:60] Registering resource: t=aws:ec2/vpc:Vpc, name=eksNetwork, custom=true
I0325 13:25:26.461664   46506 eventsink.go:60] , props={}
I0325 13:25:26.466810   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0, custom=false
I0325 13:25:26.468196   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-0, custom=true
I0325 13:25:26.470394   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-0, custom=true
I0325 13:25:26.471513   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-0, custom=true
I0325 13:25:26.478610   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1, custom=false
I0325 13:25:26.481365   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-1, custom=true
I0325 13:25:26.485713   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-1, custom=true
I0325 13:25:26.487678   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-1, custom=true
I0325 13:25:26.489171   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0, custom=false
I0325 13:25:26.492270   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-0, custom=true
I0325 13:25:26.495149   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-0, custom=true
I0325 13:25:26.497678   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-0, custom=true
I0325 13:25:26.499566   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1, custom=false
I0325 13:25:26.501108   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-1, custom=true
I0325 13:25:26.506294   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-1, custom=true
I0325 13:25:26.517305   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-1, custom=true
I0325 13:25:26.520618   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:InternetGateway, name=eksNetwork, custom=false
I0325 13:25:26.523317   46506 eventsink.go:60] Registering resource: t=aws:ec2/internetGateway:InternetGateway, name=eksNetwork, custom=true
I0325 13:25:26.524271   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-public-0-ig, custom=true
I0325 13:25:26.525348   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-public-1-ig, custom=true
I0325 13:25:26.526449   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:NatGateway, name=eksNetwork-0, custom=false
I0325 13:25:26.527378   46506 eventsink.go:60] Registering resource: t=aws:ec2/eip:Eip, name=eksNetwork-0, custom=true
I0325 13:25:26.529105   46506 eventsink.go:60] Registering resource: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-0, custom=true
I0325 13:25:26.530949   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:NatGateway, name=eksNetwork-1, custom=false
I0325 13:25:26.533409   46506 provider_plugin.go:629] Provider[aws, 0xc00014fa40].GetPluginInfo() executing
I0325 13:25:26.533685   46506 eventsink.go:60] Registering resource: t=aws:ec2/eip:Eip, name=eksNetwork-1, custom=true
I0325 13:25:26.536095   46506 eventsink.go:60] Registering resource: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-1, custom=true
I0325 13:25:26.536131   46506 provider_plugin.go:141] Provider[aws, 0xc00014fa40].Configure() executing (#vars=2)
I0325 13:25:26.536163   46506 registry.go:156] setProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:26.536219   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default' (inputs=map[region:{us-west-2} version:{0.17.1}])
I0325 13:25:26.537369   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:26.537825   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:26.538016   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0' (inputs=map[])
I0325 13:25:26.537594   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-private-0-nat-0, custom=true
I0325 13:25:26.537786   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:NatGateway,name=eksNetwork-1,#props=0
I0325 13:25:26.537809   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:26.539703   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:26.539801   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:26.540201   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:26.540453   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:26.540609   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1' (inputs=map[])
I0325 13:25:26.540063   46506 step_executor.go:310] StepExecutor worker(1): launching oneshot worker
I0325 13:25:26.540729   46506 step_executor.go:310] StepExecutor worker(1): applying step create on urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default (preview true)
I0325 13:25:26.540532   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-private-1-nat-1, custom=true
I0325 13:25:26.540771   46506 step_executor.go:310] StepExecutor worker(1): step create on urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default retired
I0325 13:25:26.540801   46506 source_eval.go:300] registered default provider for package aws: urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default
I0325 13:25:26.540833   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:26.540853   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:26.540896   46506 source_eval.go:466] ResourceMonitor.Invoke received: tok=aws:index/getAvailabilityZones:getAvailabilityZones #args=0
I0325 13:25:26.540994   46506 provider_plugin.go:584] Provider[aws, 0xc00014fa40].Invoke(aws:index/getAvailabilityZones:getAvailabilityZones) executing (#args=0)
I0325 13:25:26.540203   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:26.542105   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:26.539682   46506 eventsink.go:60] Setting AWS metadata API timeout to 100ms
I0325 13:25:26.540236   46506 step_executor.go:310] StepExecutor worker(2): launching oneshot worker
I0325 13:25:26.540436   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Vpc,name=eksNetwork,#props=0
I0325 13:25:26.540897   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/vpc:Vpc, name=eksNetwork, custom=true, #props=4, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[], deleteBeforeReplace=false
I0325 13:25:26.542895   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:26.542919   46506 step_executor.go:310] StepExecutor worker(3): launching oneshot worker
I0325 13:25:26.543995   46506 eventsink.go:60] , obj={"wrappers_":{"1":{"arr_":[],"map_":{},"arrClean":true}},"arrayIndexOffset_":-1,"array":[[]],"pivot_":1.7976931348623157e+308,"convertedFloatingPointFields_":{}}
I0325 13:25:26.544662   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:26.545194   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:26.545385   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork' (inputs=map[])
I0325 13:25:26.545546   46506 step_executor.go:310] StepExecutor worker(2): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0 (preview true)
I0325 13:25:26.545551   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:26.545775   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:26.544857   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/vpc:Vpc,name=eksNetwork,#props=4
I0325 13:25:26.548076   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:26.546387   46506 step_executor.go:310] StepExecutor worker(3): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1 (preview true)
I0325 13:25:26.546705   46506 step_executor.go:310] StepExecutor worker(4): launching oneshot worker
I0325 13:25:26.549135   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:26.552068   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:26.552315   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) executing (#olds=0,#news=4
I0325 13:25:26.552626   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/vpc:Vpc, name=eksNetwork
I0325 13:25:26.553550   46506 step_executor.go:310] StepExecutor worker(2): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0 retired
I0325 13:25:26.553712   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, stable=false, #stables=0 #outs=0
I0325 13:25:26.554757   46506 step_executor.go:310] StepExecutor worker(3): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1 retired
I0325 13:25:26.554858   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, stable=false, #stables=0 #outs=0
I0325 13:25:26.556205   46506 step_executor.go:310] StepExecutor worker(4): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork (preview true)
I0325 13:25:26.559626   46506 step_executor.go:310] StepExecutor worker(4): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork retired
I0325 13:25:26.561176   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Vpc, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, stable=false, #stables=0 #outs=0
I0325 13:25:26.568850   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:NatGateway, name=eksNetwork-0
I0325 13:25:26.569510   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:26.572193   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:26.570143   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, #outs=0
I0325 13:25:26.572562   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0,#outs=0
I0325 13:25:26.570366   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, #outs=0
I0325 13:25:26.571607   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.572159   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.572486   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/eip:Eip, name=eksNetwork-0, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[], deleteBeforeReplace=false
I0325 13:25:26.572954   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/eip:Eip, name=eksNetwork-1, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[], deleteBeforeReplace=false
I0325 13:25:26.573231   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Vpc, name=eksNetwork
I0325 13:25:26.573918   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.573979   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.574039   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:InternetGateway, name=eksNetwork, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:26.582366   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:NatGateway, name=eksNetwork-1
I0325 13:25:26.587429   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-0[awsx:x:ec2:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0,,,,
I0325 13:25:26.588235   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, #outs=0
I0325 13:25:26.590136   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0
I0325 13:25:26.592446   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/eip:Eip, name=eksNetwork-0
I0325 13:25:26.593804   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-1[awsx:x:ec2:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1,,,,
I0325 13:25:26.596060   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1
I0325 13:25:26.597637   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/eip:Eip, name=eksNetwork-1
I0325 13:25:26.598881   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[awsx:x:ec2:Vpc]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork,,,,
I0325 13:25:26.609702   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0
I0325 13:25:26.615486   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1
I0325 13:25:26.620213   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0
I0325 13:25:26.622018   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1
I0325 13:25:26.623279   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:InternetGateway, name=eksNetwork
I0325 13:25:26.624457   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork
I0325 13:25:27.241951   46506 eventsink.go:60] Ignoring AWS metadata API endpoint at default location as it doesn't return any instance-id
I0325 13:25:27.301616   46506 eventsink.go:60] No assume_role block read from configuration
I0325 13:25:27.302019   46506 eventsink.go:60] Building AWS region structure
I0325 13:25:27.302318   46506 eventsink.go:60] Building AWS auth structure
I0325 13:25:27.302886   46506 eventsink.go:60] Setting AWS metadata API timeout to 100ms
I0325 13:25:27.681466   46506 eventsink.go:60] Ignoring AWS metadata API endpoint at default location as it doesn't return any instance-id
I0325 13:25:27.682714   46506 eventsink.go:60] AWS Auth provider used: "SharedCredentialsProvider"
I0325 13:25:27.685778   46506 eventsink.go:60] Initializing DeviceFarm SDK connection
I0325 13:25:27.688017   46506 eventsink.go:60] Trying to get account information via sts:GetCallerIdentity
I0325 13:25:28.664498   46506 eventsink.go:60] Reading Availability Zones.
I0325 13:25:28.667078   46506 eventsink.go:60] Reading Availability Zones: {
I0325 13:25:28.667564   46506 eventsink.go:60] 
I0325 13:25:28.668415   46506 eventsink.go:60] }
I0325 13:25:28.712989   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) success: inputs=#5 failures=#0
I0325 13:25:28.713037   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork' (inputs=map[assignGeneratedIpv6CidrBlock:{false} cidrBlock:{10.0.0.0/16} enableDnsHostnames:{true} enableDnsSupport:{true} instanceTenancy:{default}])
I0325 13:25:28.713083   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.713124   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1,#outs=0
I0325 13:25:28.713124   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.713089   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.713194   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.713166   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0: old=#0, new=#0
I0325 13:25:28.713225   46506 step_executor.go:310] StepExecutor worker(5): launching oneshot worker
I0325 13:25:28.713237   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.713269   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.713316   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1: old=#0, new=#0
I0325 13:25:28.713379   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, #outs=0
I0325 13:25:28.713261   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork,#outs=0
I0325 13:25:28.713514   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-public-1,#props=0
I0325 13:25:28.713255   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, #outs=0
I0325 13:25:28.713556   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.713841   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.713865   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork: old=#0, new=#0
I0325 13:25:28.713897   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.714018   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.714163   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1' (inputs=map[])
I0325 13:25:28.714211   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.714244   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.713948   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-public-0,#props=0
I0325 13:25:28.714414   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/eip:Eip,name=eksNetwork-0,#props=1
I0325 13:25:28.714441   46506 step_executor.go:310] StepExecutor worker(6): launching oneshot worker
I0325 13:25:28.713962   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, #outs=0
I0325 13:25:28.714474   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.715174   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.715440   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0' (inputs=map[])
I0325 13:25:28.715561   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.715610   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.715670   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.715958   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) executing (#olds=0,#news=1
I0325 13:25:28.715627   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/eip:Eip,name=eksNetwork-1,#props=1
I0325 13:25:28.715495   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1; err: null, resp: 
I0325 13:25:28.715639   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.716237   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.715730   46506 step_executor.go:310] StepExecutor worker(6): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1 (preview true)
I0325 13:25:28.715737   46506 step_executor.go:310] StepExecutor worker(5): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork (preview true)
I0325 13:25:28.716349   46506 step_executor.go:310] StepExecutor worker(7): launching oneshot worker
I0325 13:25:28.717526   46506 step_executor.go:310] StepExecutor worker(6): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1 retired
I0325 13:25:28.717760   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, stable=false, #stables=0 #outs=0
I0325 13:25:28.718418   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) success: inputs=#1 failures=#0
I0325 13:25:28.718766   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0' (inputs=map[tags:{map[Name:{eksNetwork-0}]}])
I0325 13:25:28.718090   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0; err: null, resp: 
I0325 13:25:28.718870   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.718965   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.719021   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.719046   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) executing (#olds=0,#news=1
I0325 13:25:28.718880   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-private-1,#props=0
I0325 13:25:28.718890   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.719331   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.719385   46506 step_executor.go:310] StepExecutor worker(8): launching oneshot worker
I0325 13:25:28.720771   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) success: inputs=#1 failures=#0
I0325 13:25:28.720905   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1' (inputs=map[tags:{map[Name:{eksNetwork-1}]}])
I0325 13:25:28.721016   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.721308   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.721421   46506 step_executor.go:310] StepExecutor worker(5): step create on urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork retired
I0325 13:25:28.721567   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/vpc:Vpc, urn=urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork, stable=false, #stables=0 #outs=5
I0325 13:25:28.721385   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-private-0,#props=0
I0325 13:25:28.721451   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1' (inputs=map[])
I0325 13:25:28.720981   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, #outs=0
I0325 13:25:28.721398   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.722892   46506 step_executor.go:310] StepExecutor worker(7): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0 (preview true)
I0325 13:25:28.722899   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.723013   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.723166   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.723143   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.723703   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.723904   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0' (inputs=map[])
I0325 13:25:28.723991   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.724115   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.723314   46506 step_executor.go:310] StepExecutor worker(10): launching oneshot worker
I0325 13:25:28.724483   46506 step_executor.go:310] StepExecutor worker(11): launching oneshot worker
I0325 13:25:28.723155   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:InternetGateway,name=eksNetwork,#props=0
I0325 13:25:28.725739   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1,#outs=0
I0325 13:25:28.722913   46506 step_executor.go:310] StepExecutor worker(9): launching oneshot worker
I0325 13:25:28.725711   46506 step_executor.go:310] StepExecutor worker(8): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 (preview true)
I0325 13:25:28.726102   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.726488   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.726649   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork' (inputs=map[])
I0325 13:25:28.726741   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.726833   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.726894   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1: old=#0, new=#0
I0325 13:25:28.726866   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.727064   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.727271   46506 step_executor.go:310] StepExecutor worker(7): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0 retired
I0325 13:25:28.727528   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, stable=false, #stables=0 #outs=0
I0325 13:25:28.727294   46506 step_executor.go:310] StepExecutor worker(12): launching oneshot worker
I0325 13:25:28.728573   46506 step_executor.go:310] StepExecutor worker(10): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1 (preview true)
I0325 13:25:28.728822   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.729330   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-1, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:28.729484   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTable:RouteTable,name=eksNetwork-public-1,#props=1
I0325 13:25:28.730278   46506 step_executor.go:310] StepExecutor worker(11): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0 (preview true)
I0325 13:25:28.732410   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork; err: null, resp: 
I0325 13:25:28.732429   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.732614   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-0, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:28.732471   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, #outs=0
I0325 13:25:28.732575   46506 step_executor.go:310] StepExecutor worker(9): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 (preview true)
I0325 13:25:28.744944   46506 step_executor.go:310] StepExecutor worker(8): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 retired
I0325 13:25:28.745031   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/eip:Eip, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0, stable=false, #stables=0 #outs=1
I0325 13:25:28.753075   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.753240   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.753449   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTable:RouteTable,name=eksNetwork-public-0,#props=1
I0325 13:25:28.753398   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.753775   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1) executing (#olds=0,#news=1
I0325 13:25:28.753565   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, #outs=0
I0325 13:25:28.755727   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1) success: inputs=#1 failures=#0
I0325 13:25:28.755874   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1' (inputs=map[vpcId:output<string>{}])
I0325 13:25:28.756041   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.756083   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.756163   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.756187   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0) executing (#olds=0,#news=1
I0325 13:25:28.756214   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0,#outs=0
I0325 13:25:28.756069   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.756317   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.756466   46506 step_executor.go:310] StepExecutor worker(13): launching oneshot worker
I0325 13:25:28.756807   46506 step_executor.go:310] StepExecutor worker(12): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork (preview true)
I0325 13:25:28.757159   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0) success: inputs=#1 failures=#0
I0325 13:25:28.757201   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0' (inputs=map[vpcId:output<string>{}])
I0325 13:25:28.757240   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.757286   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.757352   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0: old=#0, new=#0
I0325 13:25:28.757337   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.757649   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.757821   46506 step_executor.go:310] StepExecutor worker(14): launching oneshot worker
I0325 13:25:28.758025   46506 step_executor.go:310] StepExecutor worker(10): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1 retired
I0325 13:25:28.758088   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, stable=false, #stables=0 #outs=0
I0325 13:25:28.759035   46506 step_executor.go:310] StepExecutor worker(11): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0 retired
I0325 13:25:28.759081   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, stable=false, #stables=0 #outs=0
I0325 13:25:28.760722   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, #outs=0
I0325 13:25:28.760746   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1,#outs=0
I0325 13:25:28.760837   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.760866   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-1, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:28.762433   46506 step_executor.go:310] StepExecutor worker(9): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 retired
I0325 13:25:28.762474   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/eip:Eip, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1, stable=false, #stables=0 #outs=1
I0325 13:25:28.763068   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, #outs=0
I0325 13:25:28.763102   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.763134   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-0, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:28.764040   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1,,,,
I0325 13:25:28.764307   46506 step_executor.go:310] StepExecutor worker(13): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1 (preview true)
I0325 13:25:28.765758   46506 step_executor.go:310] StepExecutor worker(12): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork retired
I0325 13:25:28.765802   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:InternetGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, stable=false, #stables=0 #outs=0
I0325 13:25:28.767039   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.767737   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.767808   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1: old=#0, new=#0
I0325 13:25:28.767736   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTable:RouteTable,name=eksNetwork-private-1,#props=1
I0325 13:25:28.767751   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, #outs=0
I0325 13:25:28.768360   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.768496   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/internetGateway:InternetGateway, name=eksNetwork, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:28.768597   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, #outs=0
I0325 13:25:28.769138   46506 step_executor.go:310] StepExecutor worker(14): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0 (preview true)
I0325 13:25:28.771506   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1
I0325 13:25:28.771635   46506 step_executor.go:310] StepExecutor worker(13): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1 retired
I0325 13:25:28.771668   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTable:RouteTable, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1, stable=false, #stables=0 #outs=1
I0325 13:25:28.773338   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.773504   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.773559   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.773814   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1) executing (#olds=0,#news=1
I0325 13:25:28.773477   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0,#outs=0
I0325 13:25:28.773492   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, #outs=0
I0325 13:25:28.774612   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1) success: inputs=#1 failures=#0
I0325 13:25:28.774727   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1' (inputs=map[vpcId:output<string>{}])
I0325 13:25:28.774761   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.774794   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.774875   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0: old=#0, new=#0
I0325 13:25:28.774980   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTable:RouteTable,name=eksNetwork-private-0,#props=1
I0325 13:25:28.774781   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.775042   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.775063   46506 step_executor.go:310] StepExecutor worker(15): launching oneshot worker
I0325 13:25:28.775278   46506 step_executor.go:310] StepExecutor worker(14): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0 retired
I0325 13:25:28.775327   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTable:RouteTable, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0, stable=false, #stables=0 #outs=1
I0325 13:25:28.779498   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[aws:ec2/vpc:Vpc]; err: null, resp: urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork,,assignGeneratedIpv6CidrBlock,,,,false,cidrBlock,,,10.0.0.0/16,enableDnsHostnames,,,,true,enableDnsSupport,,,,true,instanceTenancy,,,default,,
I0325 13:25:28.779832   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.779872   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.779951   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.780011   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0) executing (#olds=0,#news=1
I0325 13:25:28.779888   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/internetGateway:InternetGateway,name=eksNetwork,#props=1
I0325 13:25:28.779857   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, #outs=0
I0325 13:25:28.780781   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0) success: inputs=#1 failures=#0
I0325 13:25:28.780816   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0' (inputs=map[vpcId:output<string>{}])
I0325 13:25:28.780842   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.780901   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.780967   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.781041   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork) executing (#olds=0,#news=1
I0325 13:25:28.780888   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.781673   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.781763   46506 step_executor.go:310] StepExecutor worker(16): launching oneshot worker
I0325 13:25:28.780932   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork,#outs=0
I0325 13:25:28.781115   46506 step_executor.go:310] StepExecutor worker(15): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1 (preview true)
I0325 13:25:28.782077   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork) success: inputs=#1 failures=#0
I0325 13:25:28.782118   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork' (inputs=map[vpcId:output<string>{}])
I0325 13:25:28.782207   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.782238   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:28.782299   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork: old=#0, new=#0
I0325 13:25:28.782218   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.782364   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.782437   46506 step_executor.go:310] StepExecutor worker(17): launching oneshot worker
I0325 13:25:28.783101   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-1
I0325 13:25:28.783755   46506 step_executor.go:310] StepExecutor worker(16): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0 (preview true)
I0325 13:25:28.791954   46506 step_executor.go:310] StepExecutor worker(15): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1 retired
I0325 13:25:28.792185   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTable:RouteTable, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1, stable=false, #stables=0 #outs=1
I0325 13:25:28.800427   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, #outs=0
I0325 13:25:28.804666   46506 step_executor.go:310] StepExecutor worker(17): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork (preview true)
I0325 13:25:28.808604   46506 step_executor.go:310] StepExecutor worker(16): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0 retired
I0325 13:25:28.808795   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0,,,,
I0325 13:25:28.808826   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTable:RouteTable, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0, stable=false, #stables=0 #outs=1
I0325 13:25:28.811055   46506 step_executor.go:310] StepExecutor worker(17): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork retired
I0325 13:25:28.811354   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/internetGateway:InternetGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork, stable=false, #stables=0 #outs=1
I0325 13:25:28.818737   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0
I0325 13:25:28.818766   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.818981   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:28.819132   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/route:Route, name=eksNetwork-public-0-ig, custom=true, #props=3, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0], deleteBeforeReplace=false
I0325 13:25:28.819542   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/route:Route,name=eksNetwork-public-0-ig,#props=3
I0325 13:25:28.819667   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.819772   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.819829   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.819876   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig) executing (#olds=0,#news=3
I0325 13:25:28.819750   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-0
I0325 13:25:28.819515   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/route:Route, name=eksNetwork-public-1-ig, custom=true, #props=3, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1], deleteBeforeReplace=false
I0325 13:25:28.821208   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/route:Route,name=eksNetwork-public-1-ig,#props=3
I0325 13:25:28.822158   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig) success: inputs=#3 failures=#0
I0325 13:25:28.822209   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig' (inputs=map[destinationCidrBlock:{0.0.0.0/0} gatewayId:output<string>{} routeTableId:output<string>{}])
I0325 13:25:28.822594   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:28.822746   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:28.823045   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:28.823663   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig) executing (#olds=0,#news=3
I0325 13:25:28.822729   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.824762   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.825221   46506 step_executor.go:310] StepExecutor worker(18): launching oneshot worker
I0325 13:25:28.826235   46506 step_executor.go:310] StepExecutor worker(18): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig (preview true)
I0325 13:25:28.827542   46506 step_executor.go:310] StepExecutor worker(18): step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig retired
I0325 13:25:28.827989   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/route:Route, urn=urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig, stable=false, #stables=0 #outs=3
I0325 13:25:28.828071   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig) success: inputs=#3 failures=#0
I0325 13:25:28.828918   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig' (inputs=map[destinationCidrBlock:{0.0.0.0/0} gatewayId:output<string>{} routeTableId:output<string>{}])
I0325 13:25:28.828201   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-0[aws:ec2/eip:Eip]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0,,tags,,,,,Name,,,eksNetwork-0,,
I0325 13:25:28.829104   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:28.830227   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:28.830503   46506 step_executor.go:310] StepExecutor worker(19): launching oneshot worker
I0325 13:25:28.834115   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1; err: null, resp: 
I0325 13:25:28.836186   46506 step_executor.go:310] StepExecutor worker(19): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig (preview true)
I0325 13:25:28.841431   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1,,,,
I0325 13:25:28.841545   46506 step_executor.go:310] StepExecutor worker(19): step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig retired
I0325 13:25:28.841659   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/route:Route, urn=urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig, stable=false, #stables=0 #outs=3
I0325 13:25:28.846565   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1
I0325 13:25:28.849241   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-1
I0325 13:25:28.850953   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0,,,,
I0325 13:25:28.852372   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0
I0325 13:25:28.854324   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-0
I0325 13:25:28.857971   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-1[aws:ec2/eip:Eip]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1,,tags,,,,,Name,,,eksNetwork-1,,
I0325 13:25:28.865064   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[awsx:x:ec2:InternetGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork,,,,
I0325 13:25:28.868831   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork
I0325 13:25:28.876424   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/internetGateway:InternetGateway, name=eksNetwork
I0325 13:25:28.878561   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0; err: null, resp: 
I0325 13:25:28.880828   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1[aws:ec2/routeTable:RouteTable]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1,,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.882063   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1; err: null, resp: 
I0325 13:25:28.884628   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0[aws:ec2/routeTable:RouteTable]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0,,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.886490   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0; err: null, resp: 
I0325 13:25:28.888445   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1[aws:ec2/routeTable:RouteTable]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1,,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.896424   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork; err: null, resp: 
I0325 13:25:28.912422   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0[aws:ec2/routeTable:RouteTable]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0,,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.913513   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[aws:ec2/internetGateway:InternetGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway$aws:ec2/internetGateway:InternetGateway::eksNetwork,,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.914324   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/route:Route, name=eksNetwork-public-0-ig
I0325 13:25:28.915053   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/route:Route, name=eksNetwork-public-1-ig
I0325 13:25:28.916631   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0-ig[aws:ec2/route:Route]; err: null, resp: urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-0-ig,,destinationCidrBlock,,,0.0.0.0/0,gatewayId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:28.918221   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1-ig[aws:ec2/route:Route]; err: null, resp: urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-public-1-ig,,destinationCidrBlock,,,0.0.0.0/0,gatewayId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.034052   46506 provider_plugin.go:622] Provider[aws, 0xc00014fa40].Invoke(aws:index/getAvailabilityZones:getAvailabilityZones) success (#ret=3,#failures=0) success
I0325 13:25:29.041704   46506 eventsink.go:60] Invoke RPC finished: tok=aws:index/getAvailabilityZones:getAvailabilityZones; err: null, resp: id,,,2019-03-25 20:25:28.664936 +0000 UTC,names,,,,,,,,us-west-2a,,,us-west-2b,,,us-west-2c,,,us-west-2d,zoneIds,,,,,,,,usw2-az2,,,usw2-az1,,,usw2-az3,,,usw2-az4,
I0325 13:25:29.041820   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.041899   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.041949   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.041989   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.042039   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-0, custom=true, #props=5, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:29.042085   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/subnet:Subnet,name=eksNetwork-public-0,#props=5
I0325 13:25:29.042132   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.042170   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.042217   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.042265   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0) executing (#olds=0,#news=5
I0325 13:25:29.041999   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-1, custom=true, #props=5, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:29.042400   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/subnet:Subnet,name=eksNetwork-public-1,#props=5
I0325 13:25:29.042043   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-0, custom=true, #props=5, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:29.041962   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-1, custom=true, #props=5, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork], deleteBeforeReplace=false
I0325 13:25:29.042893   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-0
I0325 13:25:29.043490   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0) success: inputs=#6 failures=#0
I0325 13:25:29.043532   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0' (inputs=map[assignIpv6AddressOnCreation:{false} availabilityZone:{us-west-2a} cidrBlock:{10.0.0.0/18} mapPublicIpOnLaunch:{true} tags:{map[type:{public}]} vpcId:output<string>{}])
I0325 13:25:29.043580   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.043612   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.043645   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.043612   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/subnet:Subnet,name=eksNetwork-private-0,#props=5
I0325 13:25:29.043593   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-1
I0325 13:25:29.043617   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.044257   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.044335   46506 step_executor.go:310] StepExecutor worker(20): launching oneshot worker
I0325 13:25:29.043709   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1) executing (#olds=0,#news=5
I0325 13:25:29.044837   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-0
I0325 13:25:29.045054   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1) success: inputs=#6 failures=#0
I0325 13:25:29.045091   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1' (inputs=map[assignIpv6AddressOnCreation:{false} availabilityZone:{us-west-2b} cidrBlock:{10.0.64.0/18} mapPublicIpOnLaunch:{true} tags:{map[type:{public}]} vpcId:output<string>{}])
I0325 13:25:29.045139   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.045155   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/subnet:Subnet,name=eksNetwork-private-1,#props=5
I0325 13:25:29.045160   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.045205   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.045145   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.045227   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0) executing (#olds=0,#news=5
I0325 13:25:29.045252   46506 step_executor.go:310] StepExecutor worker(21): launching oneshot worker
I0325 13:25:29.045238   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.045432   46506 step_executor.go:310] StepExecutor worker(20): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0 (preview true)
I0325 13:25:29.045837   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0) success: inputs=#6 failures=#0
I0325 13:25:29.045890   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0' (inputs=map[assignIpv6AddressOnCreation:{false} availabilityZone:{us-west-2a} cidrBlock:{10.0.128.0/18} mapPublicIpOnLaunch:{false} tags:{map[type:{private}]} vpcId:output<string>{}])
I0325 13:25:29.045939   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.045964   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.046033   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.045946   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.046075   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.046086   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1) executing (#olds=0,#news=5
I0325 13:25:29.046116   46506 step_executor.go:310] StepExecutor worker(22): launching oneshot worker
I0325 13:25:29.046913   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1) success: inputs=#6 failures=#0
I0325 13:25:29.046951   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1' (inputs=map[assignIpv6AddressOnCreation:{false} availabilityZone:{us-west-2b} cidrBlock:{10.0.192.0/18} mapPublicIpOnLaunch:{false} tags:{map[type:{private}]} vpcId:output<string>{}])
I0325 13:25:29.047014   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.047048   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.047079   46506 step_executor.go:310] StepExecutor worker(23): launching oneshot worker
I0325 13:25:29.048294   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-1
I0325 13:25:29.049602   46506 step_executor.go:310] StepExecutor worker(21): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1 (preview true)
I0325 13:25:29.053024   46506 step_executor.go:310] StepExecutor worker(20): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0 retired
I0325 13:25:29.053063   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/subnet:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0, stable=false, #stables=0 #outs=6
I0325 13:25:29.055173   46506 step_executor.go:310] StepExecutor worker(22): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0 (preview true)
I0325 13:25:29.056050   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.056095   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-0, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-0 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0], deleteBeforeReplace=false
I0325 13:25:29.056128   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTableAssociation:RouteTableAssociation,name=eksNetwork-public-0,#props=2
I0325 13:25:29.056149   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.056163   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.056186   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.056210   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0) executing (#olds=0,#news=2
I0325 13:25:29.056909   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0) success: inputs=#2 failures=#0
I0325 13:25:29.056953   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0' (inputs=map[routeTableId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.056986   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.057268   46506 step_executor.go:310] StepExecutor worker(24): launching oneshot worker
I0325 13:25:29.057615   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.060000   46506 step_executor.go:310] StepExecutor worker(23): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1 (preview true)
I0325 13:25:29.062583   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0[aws:ec2/subnet:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0,,assignIpv6AddressOnCreation,,,,false,availabilityZone,,,us-west-2a,cidrBlock,,,10.0.0.0/18,mapPublicIpOnLaunch,,,,true,tags,,,,,type,,,public,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.064901   46506 step_executor.go:310] StepExecutor worker(21): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1 retired
I0325 13:25:29.064951   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/subnet:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1, stable=false, #stables=0 #outs=6
I0325 13:25:29.068294   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.068345   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-1, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-public-1 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1], deleteBeforeReplace=false
I0325 13:25:29.068388   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTableAssociation:RouteTableAssociation,name=eksNetwork-public-1,#props=2
I0325 13:25:29.068409   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.068423   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.068430   46506 step_executor.go:310] StepExecutor worker(22): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0 retired
I0325 13:25:29.068466   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/subnet:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0, stable=false, #stables=0 #outs=6
I0325 13:25:29.068443   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.069001   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1) executing (#olds=0,#news=2
I0325 13:25:29.072271   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.072593   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-0, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0], deleteBeforeReplace=false
I0325 13:25:29.072653   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTableAssociation:RouteTableAssociation,name=eksNetwork-private-0,#props=2
I0325 13:25:29.072445   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1) success: inputs=#2 failures=#0
I0325 13:25:29.072719   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1' (inputs=map[routeTableId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.072749   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.072792   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.072853   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.072910   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0) executing (#olds=0,#news=2
I0325 13:25:29.072778   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.082434   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.073423   46506 step_executor.go:310] StepExecutor worker(24): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0 (preview true)
I0325 13:25:29.082611   46506 step_executor.go:310] StepExecutor worker(25): launching oneshot worker
I0325 13:25:29.081049   46506 step_executor.go:310] StepExecutor worker(23): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1 retired
I0325 13:25:29.083210   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/subnet:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1, stable=false, #stables=0 #outs=6
I0325 13:25:29.081189   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0) success: inputs=#2 failures=#0
I0325 13:25:29.084695   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0' (inputs=map[routeTableId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.085051   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.087115   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.087312   46506 step_executor.go:310] StepExecutor worker(26): launching oneshot worker
I0325 13:25:29.093539   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.093585   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-1, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1], deleteBeforeReplace=false
I0325 13:25:29.093620   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/routeTableAssociation:RouteTableAssociation,name=eksNetwork-private-1,#props=2
I0325 13:25:29.093644   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.093660   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.093686   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.093713   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1) executing (#olds=0,#news=2
I0325 13:25:29.094388   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-0
I0325 13:25:29.094526   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1) success: inputs=#2 failures=#0
I0325 13:25:29.094562   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1' (inputs=map[routeTableId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.094612   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.094960   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.095094   46506 step_executor.go:310] StepExecutor worker(27): launching oneshot worker
I0325 13:25:29.097550   46506 step_executor.go:310] StepExecutor worker(24): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0 retired
I0325 13:25:29.097646   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTableAssociation:RouteTableAssociation, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0, stable=false, #stables=0 #outs=2
I0325 13:25:29.100143   46506 step_executor.go:310] StepExecutor worker(25): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1 (preview true)
I0325 13:25:29.101460   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.101510   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-0, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-0 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0], deleteBeforeReplace=false
I0325 13:25:29.101540   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/natGateway:NatGateway,name=eksNetwork-0,#props=2
I0325 13:25:29.101565   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.101579   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.101602   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.101637   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0) executing (#olds=0,#news=2
I0325 13:25:29.102690   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0) success: inputs=#2 failures=#0
I0325 13:25:29.102747   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0' (inputs=map[allocationId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.102782   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.102803   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.102835   46506 step_executor.go:310] StepExecutor worker(28): launching oneshot worker
I0325 13:25:29.103933   46506 step_executor.go:310] StepExecutor worker(26): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0 (preview true)
I0325 13:25:29.107730   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1[aws:ec2/subnet:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1,,assignIpv6AddressOnCreation,,,,false,availabilityZone,,,us-west-2b,cidrBlock,,,10.0.64.0/18,mapPublicIpOnLaunch,,,,true,tags,,,,,type,,,public,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.119437   46506 step_executor.go:310] StepExecutor worker(27): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1 (preview true)
I0325 13:25:29.122701   46506 step_executor.go:310] StepExecutor worker(25): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1 retired
I0325 13:25:29.122745   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTableAssociation:RouteTableAssociation, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1, stable=false, #stables=0 #outs=2
I0325 13:25:29.125721   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.125770   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-1, custom=true, #props=2, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-public-1 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1], deleteBeforeReplace=false
I0325 13:25:29.125805   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/natGateway:NatGateway,name=eksNetwork-1,#props=2
I0325 13:25:29.125834   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.125853   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.125872   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.125890   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1) executing (#olds=0,#news=2
I0325 13:25:29.125992   46506 step_executor.go:310] StepExecutor worker(28): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0 (preview true)
I0325 13:25:29.126394   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1) success: inputs=#2 failures=#0
I0325 13:25:29.126455   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1' (inputs=map[allocationId:output<string>{} subnetId:output<string>{}])
I0325 13:25:29.126516   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.126581   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.126622   46506 step_executor.go:310] StepExecutor worker(29): launching oneshot worker
I0325 13:25:29.129851   46506 step_executor.go:310] StepExecutor worker(26): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0 retired
I0325 13:25:29.129899   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTableAssociation:RouteTableAssociation, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0, stable=false, #stables=0 #outs=2
I0325 13:25:29.135418   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-1
I0325 13:25:29.149543   46506 step_executor.go:310] StepExecutor worker(27): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1 retired
I0325 13:25:29.150024   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/routeTableAssociation:RouteTableAssociation, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1, stable=false, #stables=0 #outs=2
I0325 13:25:29.155635   46506 step_executor.go:310] StepExecutor worker(28): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0 retired
I0325 13:25:29.155746   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/natGateway:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0, stable=false, #stables=0 #outs=2
I0325 13:25:29.155963   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, #outs=36
I0325 13:25:29.156101   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev,#outs=36
I0325 13:25:29.156181   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.158862   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:29.158955   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev: old=#0, new=#36
I0325 13:25:29.172885   46506 step_executor.go:310] StepExecutor worker(29): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1 (preview true)
I0325 13:25:29.173591   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.174105   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/route:Route, name=eksNetwork-private-0-nat-0, custom=true, #props=3, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-0], deleteBeforeReplace=false
I0325 13:25:29.174465   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/route:Route,name=eksNetwork-private-0-nat-0,#props=3
I0325 13:25:29.184708   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0[aws:ec2/subnet:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-0,,assignIpv6AddressOnCreation,,,,false,availabilityZone,,,us-west-2a,cidrBlock,,,10.0.128.0/18,mapPublicIpOnLaunch,,,,false,tags,,,,,type,,,private,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.187025   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.187051   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.187071   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.187160   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0) executing (#olds=0,#news=3
I0325 13:25:29.187122   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, #outs=36
I0325 13:25:29.187848   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0) success: inputs=#3 failures=#0
I0325 13:25:29.187886   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0' (inputs=map[destinationCidrBlock:{0.0.0.0/0} gatewayId:output<string>{} routeTableId:output<string>{}])
I0325 13:25:29.187927   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.187946   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.187973   46506 step_executor.go:310] StepExecutor worker(30): launching oneshot worker
I0325 13:25:29.193458   46506 step_executor.go:310] StepExecutor worker(29): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1 retired
I0325 13:25:29.193507   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/natGateway:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1, stable=false, #stables=0 #outs=2
I0325 13:25:29.196497   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:29.196610   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/route:Route, name=eksNetwork-private-1-nat-1, custom=true, #props=3, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9, deps=[urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1 urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTable:RouteTable::eksNetwork-private-1], deleteBeforeReplace=false
I0325 13:25:29.196669   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/route:Route,name=eksNetwork-private-1-nat-1,#props=3
I0325 13:25:29.196704   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:29.196728   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:29.196773   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:29.196808   46506 provider_plugin.go:187] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1) executing (#olds=0,#news=3
I0325 13:25:29.196786   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-0
I0325 13:25:29.197235   46506 provider_plugin.go:239] Provider[aws, 0xc00014fa40].Check(urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1) success: inputs=#3 failures=#0
I0325 13:25:29.197299   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1' (inputs=map[destinationCidrBlock:{0.0.0.0/0} gatewayId:output<string>{} routeTableId:output<string>{}])
I0325 13:25:29.197335   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:29.197349   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:29.197374   46506 step_executor.go:310] StepExecutor worker(31): launching oneshot worker
I0325 13:25:29.198542   46506 step_executor.go:310] StepExecutor worker(30): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0 (preview true)
I0325 13:25:29.202175   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1[aws:ec2/subnet:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/subnet:Subnet::eksNetwork-private-1,,assignIpv6AddressOnCreation,,,,false,availabilityZone,,,us-west-2b,cidrBlock,,,10.0.192.0/18,mapPublicIpOnLaunch,,,,false,tags,,,,,type,,,private,vpcId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.203319   46506 step_executor.go:310] StepExecutor worker(31): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1 (preview true)
I0325 13:25:29.210674   46506 step_executor.go:310] StepExecutor worker(30): step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0 retired
I0325 13:25:29.211864   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/route:Route, urn=urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0, stable=false, #stables=0 #outs=3
I0325 13:25:29.222156   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-1
I0325 13:25:29.224037   46506 step_executor.go:310] StepExecutor worker(31): step create on urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1 retired
I0325 13:25:29.224095   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/route:Route, urn=urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1, stable=false, #stables=0 #outs=3
I0325 13:25:29.228753   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0[aws:ec2/routeTableAssociation:RouteTableAssociation]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-0,,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.231470   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-0
I0325 13:25:29.235296   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1[aws:ec2/routeTableAssociation:RouteTableAssociation]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-public-1,,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.237598   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-1
I0325 13:25:29.243672   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0[aws:ec2/routeTableAssociation:RouteTableAssociation]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-0,,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.254979   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1[aws:ec2/routeTableAssociation:RouteTableAssociation]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet$aws:ec2/routeTableAssociation:RouteTableAssociation::eksNetwork-private-1,,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.258781   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev
I0325 13:25:29.262021   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-0[aws:ec2/natGateway:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-0,,allocationId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.264225   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/route:Route, name=eksNetwork-private-0-nat-0
I0325 13:25:29.269227   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev; err: null, resp: 
I0325 13:25:29.269898   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-1[aws:ec2/natGateway:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/natGateway:NatGateway::eksNetwork-1,,allocationId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,subnetId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.271960   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/route:Route, name=eksNetwork-private-1-nat-1
I0325 13:25:29.275478   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0-nat-0[aws:ec2/route:Route]; err: null, resp: urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-0-nat-0,,destinationCidrBlock,,,0.0.0.0/0,gatewayId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.280464   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1-nat-1[aws:ec2/route:Route]; err: null, resp: urn:pulumi:dev::eks-cluster::aws:ec2/route:Route::eksNetwork-private-1-nat-1,,destinationCidrBlock,,,0.0.0.0/0,gatewayId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,routeTableId,,,04da6b54-80e4-46f7-96ec-b56ff0331ba9,,
I0325 13:25:29.320313   46506 langruntime_plugin.go:159] langhost[nodejs].RunPlan(pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.,...,dryrun=true) success: progerr=
I0325 13:25:29.322511   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? true, <nil>)
I0325 13:25:29.322552   46506 step_generator.go:524] Planner trusts dependency graph, scheduling deletions in parallel
I0325 13:25:29.322572   46506 step_executor.go:310] StepExecutor worker(-1): StepExecutor.waitForCompletion(): waiting for worker threads to exit
I0325 13:25:29.322586   46506 step_executor.go:310] StepExecutor worker(-2): worker received nil chain, exiting
I0325 13:25:29.322622   46506 step_executor.go:310] StepExecutor worker(-1): StepExecutor.waitForCompletion(): worker threads all exited
I0325 13:25:29.322638   46506 plan_executor.go:190] planExecutor.Execute(...): step executor has completed
I0325 13:25:29.322674   46506 plan_executor.go:71] planExecutor.Execute(...): exiting provider canceller
I0325 13:25:29.325758   46506 ignore.go:44] Explicitly ignoring and discarding error: rpc error: code = Canceled desc = grpc: the client connection is closing
I0325 13:25:29.325832   46506 log.go:56] Error closing 'nodejs' language plugin during shutdown; ignoring: 1 error occurred:

* operation not permitted
I0325 13:25:31.173749   46506 backend.go:727] Stack dev being updated to version 1
I0325 13:25:31.335360   46506 plugins.go:72] gatherPluginsFromProgram(): gathering plugins from language host
I0325 13:25:31.335619   46506 plugins.go:372] GetPluginPath(language, nodejs, <nil>): found on $PATH /usr/local/bin/pulumi-language-nodejs
I0325 13:25:31.481339   46506 langruntime_plugin.go:166] langhost[nodejs].GetPluginInfo() executing
I0325 13:25:31.568752   46506 langruntime_plugin.go:83] langhost[nodejs].GetRequiredPlugins(proj=eks-cluster,pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.) executing
I0325 13:25:31.761235   46506 langruntime_plugin.go:124] langhost[nodejs].GetRequiredPlugins(proj=eks-cluster,pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.) success: #versions=3
I0325 13:25:31.761285   46506 plugins.go:79] gatherPluginsFromProgram(): plugin nodejs <nil> is required by language host
I0325 13:25:31.761312   46506 plugins.go:79] gatherPluginsFromProgram(): plugin aws 0.17.1 is required by language host
I0325 13:25:31.761326   46506 plugins.go:79] gatherPluginsFromProgram(): plugin docker 0.17.0 is required by language host
I0325 13:25:31.761335   46506 plugins.go:79] gatherPluginsFromProgram(): plugin kubernetes 0.21.1 is required by language host
I0325 13:25:31.761347   46506 plugins.go:90] gatherPluginsFromSnapshot(): gathering plugins from snapshot
I0325 13:25:31.761358   46506 plugins.go:131] ensurePluginsAreInstalled(): beginning
I0325 13:25:31.762397   46506 plugins.go:411] GetPluginPath(resource, kubernetes, 0.21.1): enabling new plugin behavior
I0325 13:25:31.762415   46506 plugins.go:492] SelectCompatiblePlugin(..., kubernetes): beginning
I0325 13:25:31.762433   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.17.5: semver mismatch
I0325 13:25:31.762445   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.20.2: semver mismatch
I0325 13:25:31.762455   46506 plugins.go:525] SelectCompatiblePlugin(..., kubernetes): skipping plugin kubernetes-0.20.3: semver mismatch
I0325 13:25:31.762464   46506 plugins.go:521] SelectCompatiblePlugin(..., kubernetes): best plugin kubernetes-0.21.1: semver match
I0325 13:25:31.762472   46506 plugins.go:534] SelectCompatiblePlugin(..., kubernetes): selecting plugin 'kubernetes-0.21.1': best match 
I0325 13:25:31.762487   46506 plugins.go:458] GetPluginPath(resource, kubernetes, 0.21.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-kubernetes-v0.21.1/pulumi-resource-kubernetes
I0325 13:25:31.762497   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin kubernetes 0.21.1 already installed
I0325 13:25:31.762546   46506 plugins.go:372] GetPluginPath(language, nodejs, <nil>): found on $PATH /usr/local/bin/pulumi-language-nodejs
I0325 13:25:31.762561   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin nodejs <nil> already installed
I0325 13:25:31.763453   46506 plugins.go:411] GetPluginPath(resource, aws, 0.17.1): enabling new plugin behavior
I0325 13:25:31.763470   46506 plugins.go:492] SelectCompatiblePlugin(..., aws): beginning
I0325 13:25:31.763483   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.15.1: semver mismatch
I0325 13:25:31.763493   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.8: semver mismatch
I0325 13:25:31.763505   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.10: semver mismatch
I0325 13:25:31.763515   46506 plugins.go:521] SelectCompatiblePlugin(..., aws): best plugin aws-0.17.1: semver match
I0325 13:25:31.763523   46506 plugins.go:534] SelectCompatiblePlugin(..., aws): selecting plugin 'aws-0.17.1': best match 
I0325 13:25:31.763534   46506 plugins.go:458] GetPluginPath(resource, aws, 0.17.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-aws-v0.17.1/pulumi-resource-aws
I0325 13:25:31.763543   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin aws 0.17.1 already installed
I0325 13:25:31.764505   46506 plugins.go:411] GetPluginPath(resource, docker, 0.17.0): enabling new plugin behavior
I0325 13:25:31.764526   46506 plugins.go:492] SelectCompatiblePlugin(..., docker): beginning
I0325 13:25:31.764540   46506 plugins.go:525] SelectCompatiblePlugin(..., docker): skipping plugin docker-0.16.4: semver mismatch
I0325 13:25:31.764550   46506 plugins.go:521] SelectCompatiblePlugin(..., docker): best plugin docker-0.17.0: semver match
I0325 13:25:31.764559   46506 plugins.go:534] SelectCompatiblePlugin(..., docker): selecting plugin 'docker-0.17.0': best match 
I0325 13:25:31.764573   46506 plugins.go:458] GetPluginPath(resource, docker, 0.17.0): found in cache at /Users/ggilmore/.pulumi/plugins/resource-docker-v0.17.0/pulumi-resource-docker
I0325 13:25:31.764586   46506 plugins.go:136] ensurePluginsAreInstalled(): plugin docker 0.17.0 already installed
I0325 13:25:31.764595   46506 plugins.go:151] ensurePluginsAreInstalled(): completed
I0325 13:25:31.764826   46506 step_generator.go:470] stepGenerator.GeneratePendingDeletes(): scanning previous snapshot for pending deletes
I0325 13:25:31.764870   46506 plan_executor.go:237] planExecutor.retirePendingDeletes(...): no pending deletions
I0325 13:25:31.764914   46506 plan_executor.go:137] planExecutor.Execute(...): waiting for incoming events
I0325 13:25:31.764960   46506 step_executor.go:310] StepExecutor worker(-2): worker coming online
I0325 13:25:31.764990   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:31.766609   46506 langruntime_plugin.go:134] langhost[nodejs].Run(pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.,#args=0,proj=eks-cluster,stack=dev,#config=1,dryrun=false) executing
I0325 13:25:32.746196   46506 eventsink.go:60] Registering resource: t=pulumi:pulumi:Stack, name=eks-cluster-dev, custom=false
I0325 13:25:32.757518   46506 eventsink.go:60] RegisterResource RPC prepared: t=pulumi:pulumi:Stack, name=eks-cluster-dev
I0325 13:25:32.759561   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=pulumi:pulumi:Stack, name=eks-cluster-dev, custom=false, #props=0, parent=, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:32.759623   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=pulumi:pulumi:Stack,name=eks-cluster-dev,#props=0
I0325 13:25:32.759647   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:32.759657   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:32.759696   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev' (inputs=map[])
I0325 13:25:32.759720   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:32.759733   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:32.759759   46506 step_executor.go:310] StepExecutor worker(0): launching oneshot worker
I0325 13:25:32.860457   46506 step_executor.go:310] StepExecutor worker(0): applying step create on urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev (preview false)
I0325 13:25:32.974387   46506 step_executor.go:310] StepExecutor worker(0): step create on urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev retired
I0325 13:25:32.974686   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=pulumi:pulumi:Stack, urn=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, stable=false, #stables=0 #outs=0
I0325 13:25:32.981896   46506 eventsink.go:60] RegisterResource RPC finished: resource:eks-cluster-dev[pulumi:pulumi:Stack]; err: null, resp: urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev,,,,
I0325 13:25:33.526228   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:33.526324   46506 source_eval.go:291] waiting for default provider for package aws
I0325 13:25:33.526345   46506 eventsink.go:60] Running program '/Users/ggilmore/dev/scripts/pulumi-eip-repro' in pwd '/Users/ggilmore/dev/scripts/pulumi-eip-repro' w/ args: 
I0325 13:25:33.526340   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=pulumi:providers:aws,name=default,#props=2
I0325 13:25:33.526456   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:33.526479   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:33.526503   46506 registry.go:218] ProviderRegistry.Check(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default) executing (#olds=0,#news=2
I0325 13:25:33.528463   46506 plugins.go:411] GetPluginPath(resource, aws, 0.17.1): enabling new plugin behavior
I0325 13:25:33.528488   46506 plugins.go:492] SelectCompatiblePlugin(..., aws): beginning
I0325 13:25:33.528502   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.15.1: semver mismatch
I0325 13:25:33.528512   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.8: semver mismatch
I0325 13:25:33.528525   46506 plugins.go:525] SelectCompatiblePlugin(..., aws): skipping plugin aws-0.16.10: semver mismatch
I0325 13:25:33.528534   46506 plugins.go:521] SelectCompatiblePlugin(..., aws): best plugin aws-0.17.1: semver match
I0325 13:25:33.528542   46506 plugins.go:534] SelectCompatiblePlugin(..., aws): selecting plugin 'aws-0.17.1': best match 
I0325 13:25:33.528554   46506 plugins.go:458] GetPluginPath(resource, aws, 0.17.1): found in cache at /Users/ggilmore/.pulumi/plugins/resource-aws-v0.17.1/pulumi-resource-aws
I0325 13:25:33.533191   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Vpc, name=eksNetwork, custom=false
I0325 13:25:33.533582   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:NatGateway, name=eksNetwork-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:33.538334   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:NatGateway,name=eksNetwork-0,#props=0
I0325 13:25:33.538362   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:NatGateway, name=eksNetwork-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:33.538424   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Vpc, name=eksNetwork, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:33.539658   46506 eventsink.go:60] Registering resource: t=aws:ec2/vpc:Vpc, name=eksNetwork, custom=true
I0325 13:25:33.540784   46506 eventsink.go:60] , props={}
I0325 13:25:33.541698   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0, custom=false
I0325 13:25:33.542848   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-0, custom=true
I0325 13:25:33.544204   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-0, custom=true
I0325 13:25:33.545787   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-0, custom=true
I0325 13:25:33.547492   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1, custom=false
I0325 13:25:33.548947   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-public-1, custom=true
I0325 13:25:33.550418   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-public-1, custom=true
I0325 13:25:33.551883   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-public-1, custom=true
I0325 13:25:33.566402   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0, custom=false
I0325 13:25:33.569672   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-0, custom=true
I0325 13:25:33.571608   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-0, custom=true
I0325 13:25:33.574171   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-0, custom=true
I0325 13:25:33.581908   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1, custom=false
I0325 13:25:33.587704   46506 eventsink.go:60] Registering resource: t=aws:ec2/subnet:Subnet, name=eksNetwork-private-1, custom=true
I0325 13:25:33.587752   46506 provider_plugin.go:629] Provider[aws, 0xc0019587d0].GetPluginInfo() executing
I0325 13:25:33.589964   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTable:RouteTable, name=eksNetwork-private-1, custom=true
I0325 13:25:33.591136   46506 eventsink.go:60] Registering resource: t=aws:ec2/routeTableAssociation:RouteTableAssociation, name=eksNetwork-private-1, custom=true
I0325 13:25:33.592300   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:InternetGateway, name=eksNetwork, custom=false
I0325 13:25:33.593490   46506 eventsink.go:60] Registering resource: t=aws:ec2/internetGateway:InternetGateway, name=eksNetwork, custom=true
I0325 13:25:33.594956   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-public-0-ig, custom=true
I0325 13:25:33.596524   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-public-1-ig, custom=true
I0325 13:25:33.598344   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:NatGateway, name=eksNetwork-0, custom=false
I0325 13:25:33.601076   46506 eventsink.go:60] Registering resource: t=aws:ec2/eip:Eip, name=eksNetwork-0, custom=true
I0325 13:25:33.602697   46506 eventsink.go:60] Registering resource: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-0, custom=true
I0325 13:25:33.604130   46506 eventsink.go:60] Registering resource: t=awsx:x:ec2:NatGateway, name=eksNetwork-1, custom=false
I0325 13:25:33.606918   46506 eventsink.go:60] Registering resource: t=aws:ec2/eip:Eip, name=eksNetwork-1, custom=true
I0325 13:25:33.616519   46506 eventsink.go:60] Registering resource: t=aws:ec2/natGateway:NatGateway, name=eksNetwork-1, custom=true
I0325 13:25:33.618779   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-private-0-nat-0, custom=true
I0325 13:25:33.620080   46506 eventsink.go:60] Registering resource: t=aws:ec2/route:Route, name=eksNetwork-private-1-nat-1, custom=true
I0325 13:25:33.621402   46506 eventsink.go:60] , obj={"wrappers_":{"1":{"arr_":[],"map_":{},"arrClean":true}},"arrayIndexOffset_":-1,"array":[[]],"pivot_":1.7976931348623157e+308,"convertedFloatingPointFields_":{}}
I0325 13:25:33.627092   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:NatGateway, name=eksNetwork-0
I0325 13:25:33.629837   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/vpc:Vpc, name=eksNetwork
I0325 13:25:33.631285   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Vpc, name=eksNetwork
I0325 13:25:33.632474   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:NatGateway, name=eksNetwork-1
I0325 13:25:33.683766   46506 registry.go:156] setProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:33.683861   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default' (inputs=map[region:{us-west-2} version:{0.17.1}])
I0325 13:25:33.683914   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:33.683939   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:33.683947   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:33.684029   46506 step_executor.go:310] StepExecutor worker(1): launching oneshot worker
I0325 13:25:33.684005   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:33.683986   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:NatGateway,name=eksNetwork-1,#props=0
I0325 13:25:33.684048   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0' (inputs=map[])
I0325 13:25:33.684137   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:33.684179   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Vpc,name=eksNetwork,#props=0
I0325 13:25:33.684186   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:33.684253   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1' (inputs=map[])
I0325 13:25:33.684172   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:33.684311   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:33.684385   46506 step_executor.go:310] StepExecutor worker(2): launching oneshot worker
I0325 13:25:33.684401   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:33.684615   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:33.684725   46506 step_executor.go:310] StepExecutor worker(3): launching oneshot worker
I0325 13:25:33.684410   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:33.685075   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:33.685147   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork' (inputs=map[])
I0325 13:25:33.685177   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:33.685192   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:33.685361   46506 step_executor.go:310] StepExecutor worker(4): launching oneshot worker
I0325 13:25:33.807312   46506 step_executor.go:310] StepExecutor worker(1): applying step create on urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default (preview false)
I0325 13:25:33.809069   46506 registry.go:314] ProviderRegistry.Create(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default) executing (#news=2)
I0325 13:25:33.809140   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::04da6b54-80e4-46f7-96ec-b56ff0331ba9)
I0325 13:25:33.809182   46506 provider_plugin.go:141] Provider[aws, 0xc0019587d0].Configure() executing (#vars=2)
I0325 13:25:33.809228   46506 registry.go:156] setProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:33.812546   46506 eventsink.go:60] Setting AWS metadata API timeout to 100ms
I0325 13:25:33.815096   46506 eventsink.go:60] Ignoring AWS metadata API endpoint at default location as it doesn't return any instance-id
I0325 13:25:33.891538   46506 eventsink.go:60] No assume_role block read from configuration
I0325 13:25:33.891977   46506 eventsink.go:60] Building AWS region structure
I0325 13:25:33.892487   46506 eventsink.go:60] Building AWS auth structure
I0325 13:25:33.893109   46506 eventsink.go:60] Setting AWS metadata API timeout to 100ms
I0325 13:25:33.894527   46506 eventsink.go:60] Ignoring AWS metadata API endpoint at default location as it doesn't return any instance-id
I0325 13:25:33.895080   46506 eventsink.go:60] AWS Auth provider used: "SharedCredentialsProvider"
I0325 13:25:33.895819   46506 eventsink.go:60] Initializing DeviceFarm SDK connection
I0325 13:25:33.896336   46506 eventsink.go:60] Trying to get account information via sts:GetCallerIdentity
I0325 13:25:33.940675   46506 step_executor.go:310] StepExecutor worker(2): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0 (preview false)
I0325 13:25:34.051460   46506 step_executor.go:310] StepExecutor worker(3): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1 (preview false)
I0325 13:25:34.163874   46506 step_executor.go:310] StepExecutor worker(4): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork (preview false)
I0325 13:25:34.259955   46506 step_executor.go:310] StepExecutor worker(1): step create on urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default retired
I0325 13:25:34.260019   46506 source_eval.go:300] registered default provider for package aws: urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default
I0325 13:25:34.260058   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:34.260248   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:34.260276   46506 source_eval.go:466] ResourceMonitor.Invoke received: tok=aws:index/getAvailabilityZones:getAvailabilityZones #args=0
I0325 13:25:34.260342   46506 provider_plugin.go:584] Provider[aws, 0xc0019587d0].Invoke(aws:index/getAvailabilityZones:getAvailabilityZones) executing (#args=0)
I0325 13:25:34.260318   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/vpc:Vpc, name=eksNetwork, custom=true, #props=4, parent=urn:pulumi:dev::eks-cluster::pulumi:pulumi:Stack::eks-cluster-dev, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18, deps=[], deleteBeforeReplace=false
I0325 13:25:34.260598   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/vpc:Vpc,name=eksNetwork,#props=4
I0325 13:25:34.260624   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:34.260639   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:34.260660   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:34.260682   46506 provider_plugin.go:187] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) executing (#olds=0,#news=4
I0325 13:25:34.336531   46506 step_executor.go:310] StepExecutor worker(2): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0 retired
I0325 13:25:34.336659   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, stable=false, #stables=0 #outs=0
I0325 13:25:34.342381   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-0[awsx:x:ec2:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0,,,,
I0325 13:25:34.342484   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, #outs=0
I0325 13:25:34.342577   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:34.342644   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/eip:Eip, name=eksNetwork-0, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18, deps=[], deleteBeforeReplace=false
I0325 13:25:34.342596   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0,#outs=0
I0325 13:25:34.343418   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0
I0325 13:25:34.345730   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/eip:Eip, name=eksNetwork-0
I0325 13:25:34.409961   46506 step_executor.go:310] StepExecutor worker(3): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1 retired
I0325 13:25:34.410111   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:NatGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, stable=false, #stables=0 #outs=0
I0325 13:25:34.415113   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-1[awsx:x:ec2:NatGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1,,,,
I0325 13:25:34.415146   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, #outs=0
I0325 13:25:34.415367   46506 source_eval.go:273] handling default provider request for package aws
I0325 13:25:34.415445   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=aws:ec2/eip:Eip, name=eksNetwork-1, custom=true, #props=1, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, protect=false, provider=urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18, deps=[], deleteBeforeReplace=false
I0325 13:25:34.416474   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1
I0325 13:25:34.418353   46506 eventsink.go:60] RegisterResource RPC prepared: t=aws:ec2/eip:Eip, name=eksNetwork-1
I0325 13:25:34.506307   46506 step_executor.go:310] StepExecutor worker(4): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork retired
I0325 13:25:34.506440   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Vpc, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, stable=false, #stables=0 #outs=0
I0325 13:25:34.513692   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[awsx:x:ec2:Vpc]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork,,,,
I0325 13:25:34.513799   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:34.513908   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, #outs=0
I0325 13:25:34.513923   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:34.513972   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:34.514127   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:34.514173   46506 source_eval.go:627] ResourceMonitor.RegisterResource received: t=awsx:x:ec2:InternetGateway, name=eksNetwork, custom=false, #props=0, parent=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, protect=false, provider=, deps=[], deleteBeforeReplace=false
I0325 13:25:34.514498   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-public-0
I0325 13:25:34.515211   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-public-1
I0325 13:25:34.516207   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-private-0
I0325 13:25:34.517370   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:Subnet, name=eksNetwork-private-1
I0325 13:25:34.518517   46506 eventsink.go:60] RegisterResource RPC prepared: t=awsx:x:ec2:InternetGateway, name=eksNetwork
I0325 13:25:34.519527   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork
I0325 13:25:34.817562   46506 eventsink.go:60] Reading Availability Zones.
I0325 13:25:34.818770   46506 eventsink.go:60] Reading Availability Zones: {
I0325 13:25:34.821370   46506 provider_plugin.go:239] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) success: inputs=#5 failures=#0
I0325 13:25:34.821714   46506 eventsink.go:60] 
I0325 13:25:34.821741   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork' (inputs=map[assignGeneratedIpv6CidrBlock:{false} cidrBlock:{10.0.0.0/16} enableDnsHostnames:{true} enableDnsSupport:{true} instanceTenancy:{default}])
I0325 13:25:34.821923   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:34.822002   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:34.822061   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0: old=#0, new=#0
I0325 13:25:34.822061   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1,#outs=0
I0325 13:25:34.822093   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:34.822642   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:34.822787   46506 step_executor.go:310] StepExecutor worker(5): launching oneshot worker
I0325 13:25:34.934204   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:34.934311   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/eip:Eip,name=eksNetwork-0,#props=1
I0325 13:25:34.934359   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:34.934491   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1: old=#0, new=#0
I0325 13:25:34.934262   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0, #outs=0
I0325 13:25:34.939338   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-0; err: null, resp: 
I0325 13:25:35.019807   46506 step_executor.go:310] StepExecutor worker(5): applying step create on urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork (preview false)
I0325 13:25:35.019926   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:35.021994   46506 provider_plugin.go:327] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) executing (#props=5)
I0325 13:25:35.058112   46506 eventsink.go:60] VPC create config: {
I0325 13:25:35.059062   46506 eventsink.go:60]   AmazonProvidedIpv6CidrBlock: false,
I0325 13:25:35.060058   46506 eventsink.go:60]   CidrBlock: "10.0.0.0/16",
I0325 13:25:35.060937   46506 eventsink.go:60]   InstanceTenancy: "default"
I0325 13:25:35.062596   46506 eventsink.go:60] }
I0325 13:25:35.097307   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.097553   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.097654   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:35.097751   46506 provider_plugin.go:187] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) executing (#olds=0,#news=1
I0325 13:25:35.098277   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1, #outs=0
I0325 13:25:35.098319   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork,#outs=0
I0325 13:25:35.099893   46506 provider_plugin.go:239] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) success: inputs=#1 failures=#0
I0325 13:25:35.100004   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0' (inputs=map[tags:{map[Name:{eksNetwork-0}]}])
I0325 13:25:35.100115   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.100178   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:35.100191   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.100228   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork: old=#0, new=#0
I0325 13:25:35.100369   46506 step_executor.go:310] StepExecutor worker(6): launching oneshot worker
I0325 13:25:35.100343   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.100264   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=aws:ec2/eip:Eip,name=eksNetwork-1,#props=1
I0325 13:25:35.101032   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway::eksNetwork-1; err: null, resp: 
I0325 13:25:35.104877   46506 provider_plugin.go:622] Provider[aws, 0xc0019587d0].Invoke(aws:index/getAvailabilityZones:getAvailabilityZones) success (#ret=3,#failures=0) success
I0325 13:25:35.110492   46506 eventsink.go:60] Invoke RPC finished: tok=aws:index/getAvailabilityZones:getAvailabilityZones; err: null, resp: id,,,2019-03-25 20:25:34.817954 +0000 UTC,names,,,,,,,,us-west-2a,,,us-west-2b,,,us-west-2c,,,us-west-2d,zoneIds,,,,,,,,usw2-az2,,,usw2-az1,,,usw2-az3,,,usw2-az4,
I0325 13:25:35.191557   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.191673   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.191612   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-public-0,#props=0
I0325 13:25:35.191607   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork, #outs=0
I0325 13:25:35.191752   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:35.191964   46506 provider_plugin.go:187] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) executing (#olds=0,#news=1
I0325 13:25:35.193237   46506 provider_plugin.go:239] Provider[aws, 0xc0019587d0].Check(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) success: inputs=#1 failures=#0
I0325 13:25:35.193325   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1' (inputs=map[tags:{map[Name:{eksNetwork-1}]}])
I0325 13:25:35.193405   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.193445   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.193495   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.193530   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-private-0,#props=0
I0325 13:25:35.193571   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.193615   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0' (inputs=map[])
I0325 13:25:35.193600   46506 step_executor.go:310] StepExecutor worker(7): launching oneshot worker
I0325 13:25:35.193713   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.193697   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.193844   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.193849   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.193886   46506 step_executor.go:310] StepExecutor worker(8): launching oneshot worker
I0325 13:25:35.193714   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-public-1,#props=0
I0325 13:25:35.194003   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0' (inputs=map[])
I0325 13:25:35.194137   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.194222   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.194260   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:Subnet,name=eksNetwork-private-1,#props=0
I0325 13:25:35.194542   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc::eksNetwork; err: null, resp: 
I0325 13:25:35.194282   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.194722   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.194858   46506 step_executor.go:310] StepExecutor worker(9): launching oneshot worker
I0325 13:25:35.194395   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1' (inputs=map[])
I0325 13:25:35.195076   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.195153   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.195241   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1' (inputs=map[])
I0325 13:25:35.195164   46506 source_eval.go:142] EvalSourceIterator produced a registration: t=awsx:x:ec2:InternetGateway,name=eksNetwork,#props=0
I0325 13:25:35.195162   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.195415   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.195494   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.195545   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:35.195612   46506 plan_executor.go:210] planExecutor.handleSingleEvent(...): received RegisterResourceEvent
I0325 13:25:35.195710   46506 step_generator.go:405] Planner decided to create 'urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork' (inputs=map[])
I0325 13:25:35.195610   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.195922   46506 step_executor.go:310] StepExecutor worker(-2): worker received chain for execution
I0325 13:25:35.195647   46506 step_executor.go:310] StepExecutor worker(11): launching oneshot worker
I0325 13:25:35.196040   46506 step_executor.go:310] StepExecutor worker(-2): worker waiting for incoming chains
I0325 13:25:35.195503   46506 step_executor.go:310] StepExecutor worker(10): launching oneshot worker
I0325 13:25:35.196149   46506 step_executor.go:310] StepExecutor worker(12): launching oneshot worker
I0325 13:25:35.285870   46506 step_executor.go:310] StepExecutor worker(6): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 (preview false)
I0325 13:25:35.285981   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:35.286058   46506 provider_plugin.go:327] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) executing (#props=1)
I0325 13:25:35.304419   46506 eventsink.go:60] EIP create configuration: {
I0325 13:25:35.306109   46506 eventsink.go:60]   Domain: ""
I0325 13:25:35.307482   46506 eventsink.go:60] }
I0325 13:25:35.357651   46506 eventsink.go:60] VPC ID: vpc-018eb3139cc784236
I0325 13:25:35.359013   46506 eventsink.go:60] Waiting for VPC (vpc-018eb3139cc784236) to become available
I0325 13:25:35.361084   46506 eventsink.go:60] Waiting for state to become: [available]
I0325 13:25:35.387410   46506 step_executor.go:310] StepExecutor worker(7): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 (preview false)
I0325 13:25:35.387484   46506 registry.go:146] GetProvider(urn:pulumi:dev::eks-cluster::pulumi:providers:aws::default::abb0ef22-4809-4b8f-b0d1-468f8e979d18)
I0325 13:25:35.387520   46506 provider_plugin.go:327] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) executing (#props=1)
I0325 13:25:35.388742   46506 eventsink.go:60] EIP create configuration: {
I0325 13:25:35.389854   46506 eventsink.go:60]   Domain: ""
I0325 13:25:35.391069   46506 eventsink.go:60] }
I0325 13:25:35.472348   46506 step_executor.go:310] StepExecutor worker(8): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0 (preview false)
I0325 13:25:35.611418   46506 step_executor.go:310] StepExecutor worker(9): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0 (preview false)
I0325 13:25:35.612317   46506 eventsink.go:60] Modifying enable_dns_hostnames vpc attribute for vpc-018eb3139cc784236: {
I0325 13:25:35.613294   46506 eventsink.go:60]   EnableDnsHostnames: {
I0325 13:25:35.614618   46506 eventsink.go:60]     Value: true
I0325 13:25:35.615791   46506 eventsink.go:60]   },
I0325 13:25:35.618888   46506 eventsink.go:60]   VpcId: "vpc-018eb3139cc784236"
I0325 13:25:35.619980   46506 eventsink.go:60] }
I0325 13:25:35.621179   46506 eventsink.go:60] EIP Allocate: {
I0325 13:25:35.623007   46506 eventsink.go:60]   Domain: "standard",
I0325 13:25:35.624622   46506 eventsink.go:60]   PublicIp: "54.203.254.111",
I0325 13:25:35.635549   46506 eventsink.go:60]   PublicIpv4Pool: "amazon"
I0325 13:25:35.637015   46506 eventsink.go:60] }
I0325 13:25:35.637748   46506 eventsink.go:60] EIP ID: 54.203.254.111 (domain: standard)
I0325 13:25:35.639213   46506 eventsink.go:60] EIP Allocate: {
I0325 13:25:35.640866   46506 eventsink.go:60]   Domain: "standard",
I0325 13:25:35.642812   46506 eventsink.go:60]   PublicIp: "54.244.254.240",
I0325 13:25:35.651780   46506 eventsink.go:60]   PublicIpv4Pool: "amazon"
I0325 13:25:35.660278   46506 eventsink.go:60] }
I0325 13:25:35.661946   46506 eventsink.go:60] EIP ID: 54.244.254.240 (domain: standard)
I0325 13:25:35.663748   46506 eventsink.go:60] Matching ^aws: with Name
I0325 13:25:35.665441   46506 eventsink.go:60] Matching ^aws: with Name
I0325 13:25:35.667456   46506 eventsink.go:60] Matching ^aws: with Name
I0325 13:25:35.669696   46506 eventsink.go:60] Matching ^aws: with Name
I0325 13:25:35.672431   46506 eventsink.go:60] Waiting for state to become: [success]
I0325 13:25:35.673017   46506 eventsink.go:60] Waiting for state to become: [success]
I0325 13:25:35.674988   46506 eventsink.go:60] Creating tags: [{
I0325 13:25:35.677650   46506 eventsink.go:60]   Key: "Name",
I0325 13:25:35.682207   46506 eventsink.go:60]   Value: "eksNetwork-0"
I0325 13:25:35.684247   46506 eventsink.go:60] }] for 54.244.254.240
I0325 13:25:35.688792   46506 eventsink.go:60] Creating tags: [{
I0325 13:25:35.691120   46506 eventsink.go:60]   Key: "Name",
I0325 13:25:35.692930   46506 eventsink.go:60]   Value: "eksNetwork-1"
I0325 13:25:35.694562   46506 eventsink.go:60] }] for 54.203.254.111
I0325 13:25:35.734878   46506 step_executor.go:310] StepExecutor worker(11): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1 (preview false)
I0325 13:25:35.808304   46506 step_executor.go:310] StepExecutor worker(10): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1 (preview false)
I0325 13:25:35.891673   46506 step_executor.go:310] StepExecutor worker(12): applying step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork (preview false)
I0325 13:25:35.893914   46506 eventsink.go:60] Modifying enable_dns_support vpc attribute for vpc-018eb3139cc784236: {
I0325 13:25:35.894804   46506 eventsink.go:60]   EnableDnsSupport: {
I0325 13:25:35.895686   46506 eventsink.go:60]     Value: true
I0325 13:25:35.896792   46506 eventsink.go:60]   },
I0325 13:25:35.898785   46506 eventsink.go:60]   VpcId: "vpc-018eb3139cc784236"
I0325 13:25:35.901343   46506 eventsink.go:60] }
I0325 13:25:35.983982   46506 provider_plugin.go:353] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) failed: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1: Error creating EIP tags: InvalidID: The ID '54.203.254.111' is not valid
	status code: 400, request id: b5b3f441-8c22-4d73-8433-537e40069208
I0325 13:25:35.984310   46506 provider_plugin.go:375] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1) success: id=54.203.254.111; #outs=4
I0325 13:25:35.983948   46506 provider_plugin.go:353] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) failed: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0: Error creating EIP tags: InvalidID: The ID '54.244.254.240' is not valid
	status code: 400, request id: b5ad936a-ab1f-4d3c-82e8-e932c4d2c04e
I0325 13:25:35.984374   46506 eventsink.go:87] eventSink::Error(<{%reset%}>Plan apply failed: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1: Error creating EIP tags: InvalidID: The ID '54.203.254.111' is not valid
	status code: 400, request id: b5b3f441-8c22-4d73-8433-537e40069208<{%reset%}>)
I0325 13:25:35.984422   46506 provider_plugin.go:375] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0) success: id=54.244.254.240; #outs=4
I0325 13:25:35.984558   46506 eventsink.go:87] eventSink::Error(<{%reset%}>Plan apply failed: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0: Error creating EIP tags: InvalidID: The ID '54.244.254.240' is not valid
	status code: 400, request id: b5ad936a-ab1f-4d3c-82e8-e932c4d2c04e<{%reset%}>)
I0325 13:25:35.999055   46506 step_executor.go:310] StepExecutor worker(8): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0 retired
I0325 13:25:35.999185   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, stable=false, #stables=0 #outs=0
I0325 13:25:36.001764   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-0[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0,,,,
I0325 13:25:36.001925   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, #outs=0
I0325 13:25:36.002213   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0,#outs=0
I0325 13:25:36.003190   46506 plan_executor.go:141] planExecutor.Execute(...): incoming event (nil? false, <nil>)
I0325 13:25:36.003254   46506 plan_executor.go:216] planExecutor.handleSingleEvent(...): received register resource outputs
I0325 13:25:36.003285   46506 step_executor.go:310] StepExecutor worker(-1): registered resource outputs urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0: old=#0, new=#0
I0325 13:25:36.004539   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0
I0325 13:25:36.126319   46506 step_executor.go:310] StepExecutor worker(9): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0 retired
I0325 13:25:36.126463   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, stable=false, #stables=0 #outs=0
I0325 13:25:36.129315   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-0[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0,,,,
I0325 13:25:36.129553   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0, #outs=0
I0325 13:25:36.129624   46506 source_eval.go:147] EvalSourceIterator produced a completion: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0,#outs=0
I0325 13:25:36.130623   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-0
I0325 13:25:36.277369   46506 step_executor.go:310] StepExecutor worker(11): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1 retired
I0325 13:25:36.277569   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, stable=false, #stables=0 #outs=0
I0325 13:25:36.282036   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-private-1[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1,,,,
I0325 13:25:36.282079   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1, #outs=0
I0325 13:25:36.283218   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-private-1
I0325 13:25:36.373351   46506 step_executor.go:310] StepExecutor worker(10): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1 retired
I0325 13:25:36.373530   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:Subnet, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, stable=false, #stables=0 #outs=0
I0325 13:25:36.376968   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-public-1[awsx:x:ec2:Subnet]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1,,,,
I0325 13:25:36.377059   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1, #outs=0
I0325 13:25:36.378084   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-1
I0325 13:25:36.466271   46506 step_executor.go:310] StepExecutor worker(12): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork retired
I0325 13:25:36.466412   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=awsx:x:ec2:InternetGateway, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, stable=false, #stables=0 #outs=0
I0325 13:25:36.469391   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork[awsx:x:ec2:InternetGateway]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork,,,,
I0325 13:25:36.469396   46506 source_eval.go:697] ResourceMonitor.RegisterResourceOutputs received: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork, #outs=0
I0325 13:25:36.470894   46506 eventsink.go:60] RegisterResourceOutputs RPC prepared: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:InternetGateway::eksNetwork
I0325 13:25:36.560129   46506 step_executor.go:310] StepExecutor worker(7): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 retired
I0325 13:25:36.560287   46506 step_executor.go:310] StepExecutor worker(7): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 failed with an error: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1: Error creating EIP tags: InvalidID: The ID '54.203.254.111' is not valid
	status code: 400, request id: b5b3f441-8c22-4d73-8433-537e40069208
I0325 13:25:36.560351   46506 step_executor.go:310] StepExecutor worker(7): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1 failed, signalling cancellation
I0325 13:25:36.560363   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/eip:Eip, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1, stable=false, #stables=0 #outs=4
I0325 13:25:36.560416   46506 step_executor.go:310] StepExecutor worker(-2): worker exiting due to cancellation
I0325 13:25:36.563834   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-1[aws:ec2/eip:Eip]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-1,54.203.254.111,__meta,,,{"e2bfb730-ecaa-11e6-8f88-34363bc7c4c0":{"delete":180000000000,"read":900000000000,"update":300000000000}},domain,,,standard,id,,,54.203.254.111,tags,,,,,Name,,,eksNetwork-1,,
I0325 13:25:36.630422   46506 step_executor.go:310] StepExecutor worker(6): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 retired
I0325 13:25:36.630665   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/eip:Eip, urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0, stable=false, #stables=0 #outs=4
I0325 13:25:36.630714   46506 step_executor.go:310] StepExecutor worker(6): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 failed with an error: 1 error occurred:

* creating urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0: Error creating EIP tags: InvalidID: The ID '54.244.254.240' is not valid
	status code: 400, request id: b5ad936a-ab1f-4d3c-82e8-e932c4d2c04e
I0325 13:25:36.630920   46506 step_executor.go:310] StepExecutor worker(6): step create on urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0 failed, signalling cancellation
I0325 13:25:36.634533   46506 eventsink.go:60] RegisterResource RPC finished: resource:eksNetwork-0[aws:ec2/eip:Eip]; err: null, resp: urn:pulumi:dev::eks-cluster::awsx:x:ec2:NatGateway$aws:ec2/eip:Eip::eksNetwork-0,54.244.254.240,__meta,,,{"e2bfb730-ecaa-11e6-8f88-34363bc7c4c0":{"delete":180000000000,"read":900000000000,"update":300000000000}},domain,,,standard,id,,,54.244.254.240,tags,,,,,Name,,,eksNetwork-0,,
I0325 13:25:36.785284   46506 source_eval.go:721] ResourceMonitor.RegisterResourceOutputs operation finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0, #outs=0
I0325 13:25:36.785250   46506 plan_executor.go:180] planExecutor.Execute(...): context finished: context canceled
I0325 13:25:36.785503   46506 step_executor.go:310] StepExecutor worker(-1): StepExecutor.waitForCompletion(): waiting for worker threads to exit
I0325 13:25:36.787012   46506 eventsink.go:60] RegisterResourceOutputs RPC finished: urn=urn:pulumi:dev::eks-cluster::awsx:x:ec2:Vpc$awsx:x:ec2:Subnet::eksNetwork-public-0; err: null, resp: 
I0325 13:25:38.761891   46506 provider_plugin.go:375] Provider[aws, 0xc0019587d0].Create(urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork) success: id=vpc-018eb3139cc784236; #outs=19
I0325 13:25:38.880166   46506 step_executor.go:310] StepExecutor worker(5): step create on urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork retired
I0325 13:25:38.880275   46506 step_executor.go:310] StepExecutor worker(-1): StepExecutor.waitForCompletion(): worker threads all exited
I0325 13:25:38.880314   46506 plan_executor.go:190] planExecutor.Execute(...): step executor has completed
I0325 13:25:38.880342   46506 source_eval.go:662] ResourceMonitor.RegisterResource operation finished: t=aws:ec2/vpc:Vpc, urn=urn:pulumi:dev::eks-cluster::aws:ec2/vpc:Vpc::eksNetwork, stable=false, #stables=0 #outs=19
I0325 13:25:38.880491   46506 plan_executor.go:122] planExecutor.Execute(...): incoming events goroutine exiting
I0325 13:25:38.880404   46506 plan_executor.go:71] planExecutor.Execute(...): exiting provider canceller
I0325 13:25:38.886284   46506 langruntime_plugin.go:153] langhost[nodejs].Run(pwd=/Users/ggilmore/dev/scripts/pulumi-eip-repro,program=.,...,dryrun=false) failed: err=transport is closing
I0325 13:25:38.886370   46506 ignore.go:44] Explicitly ignoring and discarding error: rpc error: code = Canceled desc = grpc: the client connection is closing
I0325 13:25:38.904635   46506 ignore.go:44] Explicitly ignoring and discarding error: 1 error occurred:

* operation not permitted
I0325 13:25:39.056289   46506 sink.go:154] defaultSink::Error(error: update failed
github.com/pulumi/pulumi/pkg/resource/deploy.execError
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan_executor.go:46
github.com/pulumi/pulumi/pkg/resource/deploy.(*planExecutor).Execute
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan_executor.go:194
github.com/pulumi/pulumi/pkg/resource/deploy.(*Plan).Execute
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan.go:300
github.com/pulumi/pulumi/pkg/engine.(*planResult).Walk.func1
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/engine/plan.go:216
runtime.goexit
	/usr/local/Cellar/go/1.12.1/libexec/src/runtime/asm_amd64.s:1337
)
error: update failed
github.com/pulumi/pulumi/pkg/resource/deploy.execError
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan_executor.go:46
github.com/pulumi/pulumi/pkg/resource/deploy.(*planExecutor).Execute
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan_executor.go:194
github.com/pulumi/pulumi/pkg/resource/deploy.(*Plan).Execute
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/resource/deploy/plan.go:300
github.com/pulumi/pulumi/pkg/engine.(*planResult).Walk.func1
	/private/tmp/pulumi-20190315-88166-3a0j8e/src/github.com/pulumi/pulumi/pkg/engine/plan.go:216
runtime.goexit
	/usr/local/Cellar/go/1.12.1/libexec/src/runtime/asm_amd64.s:1337