Skip to content

Instantly share code, notes, and snippets.

@amaltson

amaltson/lattice.out

Last active September 15, 2015 19:25
Show Gist options
  • Save amaltson/d710e66d5ba6b3060ff5 to your computer and use it in GitHub Desktop.
Save amaltson/d710e66d5ba6b3060ff5 to your computer and use it in GitHub Desktop.
Download ZIP
Failing lattice with proxy, ltc test -v
Raw
lattice.out
ltc test -v
Running Suite: Lattice Integration Tests
========================================
Random Seed: 1442344933
Will run 5 of 5 specs
Lattice docker when desiring a docker-based LRP
should run a docker app
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:138
[test] Attempting to stream cluster debug logs
[test] Attempting to create lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[create] No port specified, image metadata did not contain exposed ports. Defaulting to 8080.
[create] Monitoring the app on port 8080...
[create] Creating App: lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.48 14 rep.auction-fetch-state.handling
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.48 9.1 rep.auction-delegate.auction-state.providing
[create] .[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:15.49 4.9 garden-linux.garden-server.bulk_info.got-bulkinfo
[debug] {"handles":[""]}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:15.49 4.11 garden-linux.garden-server.bulk_info.got-bulkinfo
[debug] {"handles":[""]}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.49 9 rep.auction-delegate.provided
[debug] {"available-resources":{"Containers":256,"DiskMB":8675,"MemoryMB":3951},"evacuating":false,"num-lrps":0,"total-resources":{"Containers":256,"DiskMB":8675,"MemoryMB":3951},"zone":"z1"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.49 14 rep.auction-fetch-state.success
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 15 rep.auction-perform-work.handling
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 9.2.1 rep.auction-delegate.auction-work.lrp-allocate-instances.requesting-container-allocation
[debug] {"lrp-starts":1,"num-requesting-allocation":1,"tasks":0}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:15.50 4.13 garden-linux.garden-server.bulk_info.got-bulkinfo
[debug] {"handles":[""]}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 9.2.1 rep.auction-delegate.auction-work.lrp-allocate-instances.succeeded-requesting-container-allocation
[debug] {"lrp-starts":1,"num-failed-to-allocate":0,"tasks":0}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 15 rep.auction-perform-work.success
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 12.1.1 rep.event-consumer.operation-stream.executing-container-operation.starting
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 12.1.1 rep.event-consumer.operation-stream.executing-container-operation.fetch-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.50 12.1.1 rep.event-consumer.operation-stream.executing-container-operation.succeeded-fetch-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
09/15 15:22:15.51 [APP|0] Creating container
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.51 12.1.1.1.1 rep.event-consumer.operation-stream.executing-container-operation.ordinary-lrp-processor.process-reserved-container.running-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","container-state":"reserved","lrp-instance-key":{"cell_id":"cell-01","instance_guid":"5d7a91c8-a741-4118-5663-88f330badfd6"},"lrp-key":{"domain":"lattice","index":0,"process_guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35"}}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.51 12.1.1.1.1 rep.event-consumer.operation-stream.executing-container-operation.ordinary-lrp-processor.process-reserved-container.succeeded-running-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","container-state":"reserved","lrp-instance-key":{"cell_id":"cell-01","instance_guid":"5d7a91c8-a741-4118-5663-88f330badfd6"},"lrp-key":{"domain":"lattice","index":0,"process_guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35"}}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.51 12.1.1 rep.event-consumer.operation-stream.executing-container-operation.finished
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:15.51 4.5 rep.depot-client.run-container.creating-container-in-garden
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:15.51 2.1 garden-linux.pool.11t202nbmge.creating
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:15.51 2.1 garden-linux.pool.11t202nbmge.acquired-pool-resources
[create] .[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:17.42 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"cf2616975b4a3cba083ca99bc3f0bf25f5f528c3c52be1596b30f60b0b1c37ff","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:17.44 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"cf2616975b4a3cba083ca99bc3f0bf25f5f528c3c52be1596b30f60b0b1c37ff","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":2.1579087e+07,"vols":null}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:18.15 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"47f0a47155d5917ed589420c7e528600fb322c4cb8ec5e89bc2ec84a3567ffce","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:18.64 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"47f0a47155d5917ed589420c7e528600fb322c4cb8ec5e89bc2ec84a3567ffce","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":4.8359215e+08,"vols":null}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:19.39 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"32e97f5f5d6bd15b9cc293b38a5102a7ddac736852811110043992b20553177a","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:19.44 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"32e97f5f5d6bd15b9cc293b38a5102a7ddac736852811110043992b20553177a","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":4.3862825e+07,"vols":null}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:20.22 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"92f2e3e19c58e8a5780d20b05a41d6d52db83f7bd8650879cd191eaa4b002aae","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:20.24 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"92f2e3e19c58e8a5780d20b05a41d6d52db83f7bd8650879cd191eaa4b002aae","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":2.1241093e+07,"vols":null}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:21.16 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"1b4a5e48bd37d905ca6d1aebcf1feda908983abff30b536f2144009a62337729","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:21.68 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"1b4a5e48bd37d905ca6d1aebcf1feda908983abff30b536f2144009a62337729","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":5.24665766e+08,"vols":null}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:22.41 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloading
[debug] {"layer":"b7ae28d276a360706015215689b73b2569659c54945e7556ff4fa964afa833a7","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest"}
.[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:22.88 2.1.1.1 garden-linux.pool.11t202nbmge.create-rootfs.fetch.downloaded
[debug] {"layer":"b7ae28d276a360706015215689b73b2569659c54945e7556ff4fa964afa833a7","repo":{"Fragment":"latest","Host":"","Opaque":"","Path":"/cloudfoundry/lattice-app","RawQuery":"","Scheme":"docker","User":null},"tag":"latest","took":4.72578836e+08,"vols":null}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:22.91 6 garden-linux.namespace-rootfs.namespace
[debug] {"path":"/var/lattice/garden/graph/btrfs/subvolumes/b7ae28d276a360706015215689b73b2569659c54945e7556ff4fa964afa833a7@namespaced"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:22.92 6 garden-linux.namespace-rootfs.namespaced
[debug] {"path":"/var/lattice/garden/graph/btrfs/subvolumes/b7ae28d276a360706015215689b73b2569659c54945e7556ff4fa964afa833a7@namespaced"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.09 2.1 garden-linux.pool.11t202nbmge.created
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.28 9 garden-linux.start.started
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.28 4.14 garden-linux.garden-server.create.created
[debug] {"request":{"env":["INSTANCE_GUID=5d7a91c8-a741-4118-5663-88f330badfd6","INSTANCE_INDEX=0","PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin","PROCESS_GUID=lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35","APP_NAME=LATTICE-TEST-APP","VCAP_APPLICATION={\"application_name\":\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35\",\"application_uris\":[\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io\",\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-8080.192.168.11.11.xip.io\"],\"name\":\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35\",\"uris\":[\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io\",\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-8080.192.168.11.11.xip.io\"],\"limits\":{\"mem\":128}}","PORT=8080","VCAP_SERVICES={}"],"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","properties":{"executor:allocated-at":"1442344935505643395","executor:cpu-weight":"100","executor:disk-mb":"0","executor:log-config":"{\"guid\":\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35\",\"index\":0,\"source_name\":\"APP\"}","executor:memory-mb":"128","executor:metrics-config":"{\"guid\":\"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35\",\"index\":0}","executor:owner":"executor","executor:result":"{\"failed\":false,\"failure_reason\":\"\",\"stopped\":false}","executor:rootfs":"docker:///cloudfoundry/lattice-app#latest","executor:start-timeout":"0","executor:state":"created","tag:domain":"lattice","tag:instance-guid":"5d7a91c8-a741-4118-5663-88f330badfd6","tag:lifecycle":"lrp","tag:process-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35","tag:process-index":"0"},"rootfs":"docker:///cloudfoundry/lattice-app#latest"}}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.29 4.16 garden-linux.garden-server.net-in.port-mapped
[debug] {"container-port":8080,"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","host-port":60000}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.30 4.17 garden-linux.garden-server.net-in.port-mapped
[debug] {"container-port":2222,"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","host-port":60001}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.30 4.18 garden-linux.garden-server.limit-memory.limited
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","resulting-limits":{"limit_in_bytes":1.34217728e+08}}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.31 4.19 garden-linux.garden-server.limit-disk.limited
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","resulting-limits":{}}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.31 4.20 garden-linux.garden-server.limit-cpu.limited
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","resulting-limits":{"limit_in_shares":1024}}
09/15 15:22:23.31 [APP|0] Successfully created container
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.31 4.21 garden-linux.garden-server.info.got-info
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.31 4.5 rep.depot-client.run-container.succeeded-creating-container-in-garden
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.31 4.5 rep.depot-client.run-container.running-container-in-garden
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.31 4.5.2 rep.depot-client.run-container.run.started
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.32 4.5.2.4 rep.depot-client.run-container.run.run-step-process.started
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.32 4.5.2 rep.depot-client.run-container.run.stored-step-process
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","num-step-processes":1}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.32 4.5.2 rep.depot-client.run-container.run.finished
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.32 4.5 rep.depot-client.run-container.succeeded-running-container-in-garden
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.32 4.5.2.1.1 rep.depot-client.run-container.run.setup.download-step.fetch-starting
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.42 4.5.2.1.1 rep.depot-client.run-container.run.setup.download-step.fetch-complete
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.42 4.5.2.1.1 rep.depot-client.run-container.run.setup.download-step.stream-in-starting
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.44 4.23 garden-linux.garden-server.stream-in.streamed-in
[debug] {"destination":"/tmp","handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.44 4.5.2.1.1 rep.depot-client.run-container.run.setup.download-step.stream-in-complete
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.44 4.5.2.1.2 rep.depot-client.run-container.run.setup.download-step.fetch-starting
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[create] .[debug] [rep|cell-01] [INFO] 09/15 15:22:23.61 4.5.2.1.2 rep.depot-client.run-container.run.setup.download-step.fetch-complete
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.61 4.5.2.1.2 rep.depot-client.run-container.run.setup.download-step.stream-in-starting
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.63 4.24 garden-linux.garden-server.stream-in.streamed-in
[debug] {"destination":"/tmp","handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.64 4.5.2.1.2 rep.depot-client.run-container.run.setup.download-step.stream-in-complete
[debug] {"cacheKey":"","guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","to":"/tmp","user":"vcap"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.64 4.5.2.2.1 rep.depot-client.run-container.run.action.run-step.running
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.64 4.5.2.2.1 rep.depot-client.run-container.run.action.run-step.creating-process
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.64 4.5.2.2.2 rep.depot-client.run-container.run.action.run-step.running
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.64 4.5.2.2.2 rep.depot-client.run-container.run.action.run-step.creating-process
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.64 garden-linux.next pid
[debug] {"pid":1}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.64 garden-linux.next pid
[debug] {"pid":2}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.65 4.25 garden-linux.garden-server.run.spawned
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","id":1,"spec":{"args":["-address=0.0.0.0:2222","-authorizedKey=ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDBKjdYqXFRLtCbB4E+YEgC+1b9ybfxd/WJ7zYNV0RFHPXP/hhtNgCZR9hBe5MM7XckRFRDSnAKQYS2IRVgdN7vQD6QSo22A7l+Dp6tmyvZH52jW2q15sUWhjB45cJCRWXBu4qbWRX/H+nmlZWouEaVr4vi6jf5vzlmmSu81Q+5kGLqmnUMhkHZ5+IeYk01TAycSLPJSnfs+YsTph07bxh3Q37Ja8WAG4cIt5q7vBn8lX8C6/2ThX7+BCd4wV7DCuAAtXhD++FhHhIQL5EvwrZfJNhXOHYQ3cfy+UPoOT7lhSDXSvIABQRzS+Z/Vbm9utg2zIiUBIl586u8ccYAZ/P3","-hostKey=-----BEGIN RSA PRIVATE KEY-----\nMIIEowIBAAKCAQEAtqrPLMTgC2iFxOsaucY42yfiX3yiRJ8JNQOP2h1cP0kDmdoQ\nkLfxoFOEOCHoZINJyzQLc2X6md89W3qfBcqAh0gl62M6EvM+4qDPM+P98xlIwDlG\nbeGa+xMf1mWt1jykI676+ThESH03DnBQf9iwml8wqyB4+C/xNVgo/CAojG/7vNPG\neMqwUZjAeumIPO2IPz+DL7V5HzZz6dQ8jUXwSyTqcq3n6Wv6RLJPykRmomAW+zQJ\nRtXOaAEWbLUyXY+PUUykmE6QCuQF36KJakGZcxm9ch/LOVNSSw2RKch5YzIKoArv\nqlVclUNVm0XJ92W3VM/SnLB6c/0AkkVPcYCZNwIDAQABAoIBAB6rAMt4ZlEkBEly\nW3NTN1p8EMKNT0UMGmSfK3ioM0Ogw40CEoPpjhSn0OwHrVeqvynxm/aM6Y0J8Og5\n5xb2z6tmzo79gtOJqUYtT3xby9gTp6Y2N3/dP8LljBPX0F7GoZwoFZTgAH7XHvY6\nnxlHzSat0qL4ebbZfbrCCWeDEqu5HKMwbGYDaYvvwTYAV9UFISivFKTlHQLYl/wz\nl3dqPB4xNeTD9ty7mL+4kOrsht4jZ88Mq9pwKEsmIM2/9FG/lGmUviBGP3yFlGet\n5e/EU5H/VGPEuwPki1rtHzzqd7Q2drkLI70GV2r6/n39CRHeipoVGMANmSIjzeql\nPW8IiWkCgYEA5T/VQxheouU6el7rZtETD/+ypmxcIcoHSM7Y9A74NUIlsKkP3Xdq\neM/lfWt+dm5ZkT4xjM9e8Psfc99forxtQ8izr+Cl8IjbO5c0sK0joQmta473MoOo\n2gsHZCcuSDEZ4kOET6yCtB25oQjsZ73vrgmwLRDP/6edVGwamDL8KZ0CgYEAy/t4\nBROZ0+CflERM6hXcmybzvRkdUOmEQelFaud5gWrq45AbLRKgVYWdRhABkyszf2BC\nPQRFr6FEeL7H6ejvtc+Id4VHPE4x/yNb0vn5znpu5Lgc6/0gkGm01S2+uq8lsz/7\nMdJEMA5RV9sFZASnyskSUaTzLnepirpksZt9j+MCgYBBn2wksK0mZAfBT7qCzAZw\n5fj1ur8EzRgYt11TP5W9aRnw3/QyqSRJQPmoVUT2EdCByxPUAuhigwAV4zM1GksM\nxD7rcZsOp55aCIaErIsuZd7Gkz4fr6B+CforqSuObr/CDSGqzO79MCUa+7rwV2Zs\no0lTHSTtQcW/jNJwDugv4QKBgQCy9gtUmN/LDjWzhUDd1xRXYxNRAmnABUAt+5UV\nt8PYkY9G27WcE81revCC+aQIFEz4IeG7WrYw4pIKRYdrZxx4LH4ULnBTLl+a8tCr\nBvnt92i3bfih6tDZIoSuy5Wcf/HZk/a0vT9p0gX3yIawO41i0oop60gXqpCqz+Fs\nGXlN9QKBgAdHE69MCU4zPqeSnbKQ+AMItjj0Wq0quRbtRfRv586GEj0/sPTL7vCx\nc09M7CVo4xO5nIVjqWkZAuEt87BFR4ZypVw5OmuV3IyXo4857Y63+Ddsn0x987F9\nhJx9Ug56UrAOSLh8JItE+unOaYeyag1E9Cn/xwOJ+n38EkOpSJqM\n-----END RSA PRIVATE KEY-----\n"],"dir":"/tmp","env":["CF_INSTANCE_IP=192.168.11.11","CF_INSTANCE_PORT=60000","CF_INSTANCE_ADDR=192.168.11.11:60000","CF_INSTANCE_PORTS=60000:8080,60001:2222"],"path":"/tmp/diego-sshd","rlimits":{},"user":"vcap"}}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:23.65 4.26 garden-linux.garden-server.run.spawned
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","id":2,"spec":{"args":["--message","Hello Lattice User","--quiet"],"dir":"/","env":["CF_INSTANCE_IP=192.168.11.11","CF_INSTANCE_PORT=60000","CF_INSTANCE_ADDR=192.168.11.11:60000","CF_INSTANCE_PORTS=60000:8080,60001:2222"],"path":"/lattice-app","rlimits":{},"user":"vcap"}}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.65 4.5.2.2.1 rep.depot-client.run-container.run.action.run-step.successful-process-create
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","process":1}
[debug] [rep|cell-01] [INFO] 09/15 15:22:23.65 4.5.2.2.2 rep.depot-client.run-container.run.action.run-step.successful-process-create
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","process":2}
09/15 15:22:23.68 [APP|0] {"timestamp":"1442344943.682227850","source":"lattice-app","message":"lattice-app.lattice-app.starting","log_level":1,"data":{"ports":["8080"]}}
[create] 09/15 15:22:23.68 [APP|0] {"timestamp":"1442344943.684732676","source":"lattice-app","message":"lattice-app.lattice-app.up","log_level":1,"data":{"port":"8080"}}
[create] 09/15 15:22:23.80 [APP|0] {"timestamp":"1442344943.803207397","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.14 4.5.2.5.1 rep.depot-client.run-container.run.monitor-run.run-step.running
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.14 4.5.2.5.1 rep.depot-client.run-container.run.monitor-run.run-step.creating-process
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:24.14 garden-linux.next pid
[debug] {"pid":3}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:24.15 4.27 garden-linux.garden-server.run.spawned
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","id":3,"spec":{"args":["-timeout","1s","-port","8080"],"env":["CF_INSTANCE_IP=192.168.11.11","CF_INSTANCE_PORT=60000","CF_INSTANCE_ADDR=192.168.11.11:60000","CF_INSTANCE_PORTS=60000:8080,60001:2222"],"path":"/tmp/healthcheck","rlimits":{},"user":"vcap"}}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.16 4.5.2.5.1 rep.depot-client.run-container.run.monitor-run.run-step.successful-process-create
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","process":3}
[create] 09/15 15:22:24.17 [HEALTH|0] healthcheck passed
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:24.17 4.27 garden-linux.garden-server.run.exited
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","id":3,"status":0}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.17 4.5.2.5.1 rep.depot-client.run-container.run.monitor-run.run-step.process-exit
[debug] {"cancelled":false,"exitStatus":0,"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6","process":3}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 4.5.2.3.1 rep.depot-client.run-container.run.monitor.monitor-step.transitioned-to-healthy
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[create] 09/15 15:22:24.18 [HEALTH|0] Exit status 0
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 4.5.2.4 rep.depot-client.run-container.run.run-step-process.transitioning-to-running
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 4.5.2.4 rep.depot-client.run-container.run.run-step-process.succeeded-transitioning-to-running
[debug] {"guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:24.18 4.29 garden-linux.garden-server.info.got-info
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 12.1.2 rep.event-consumer.operation-stream.executing-container-operation.starting
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 12.1.2 rep.event-consumer.operation-stream.executing-container-operation.fetch-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [garden-linux|cell-01] [INFO] 09/15 15:22:24.18 4.31 garden-linux.garden-server.info.got-info
[debug] {"handle":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.18 12.1.2 rep.event-consumer.operation-stream.executing-container-operation.succeeded-fetch-container
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[debug] [rep|cell-01] [INFO] 09/15 15:22:24.19 12.1.2 rep.event-consumer.operation-stream.executing-container-operation.finished
[debug] {"container-guid":"lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-5d7a91c8-a741-4118-5663-88f330badfd6"}
[create]
[create] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35 is now running.
[create] App is reachable at:
[create] http://lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io
[create] http://lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35-8080.192.168.11.11.xip.io
[test] Yay! Created lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[test] Polling for the appRoute lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io
[test] Attempting to stream logs from lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs] 09/15 15:22:24.68 [APP|0] LATTICE-TEST-APP. Says Hello Lattice User. on index: 0
[test] Attempting to scale lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[scale] Scaling lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35 to 3 instances
[scale] .[logs] 09/15 15:22:24.76 [APP|1] Creating container
[logs] 09/15 15:22:24.76 [APP|2] Creating container
[logs] 09/15 15:22:25.68 [APP|0] LATTICE-TEST-APP. Says Hello Lattice User. on index: 0
.[logs] 09/15 15:22:26.01 [APP|2] Successfully created container
[logs] 09/15 15:22:26.36 [APP|2] {"timestamp":"1442344946.360141277","source":"lattice-app","message":"lattice-app.lattice-app.starting","log_level":1,"data":{"ports":["8080"]}}
[logs] 09/15 15:22:26.36 [APP|2] {"timestamp":"1442344946.360881567","source":"lattice-app","message":"lattice-app.lattice-app.up","log_level":1,"data":{"port":"8080"}}
[logs] 09/15 15:22:26.49 [APP|2] {"timestamp":"1442344946.493430376","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[logs] 09/15 15:22:26.68 [APP|0] LATTICE-TEST-APP. Says Hello Lattice User. on index: 0
.[logs] 09/15 15:22:26.85 [HEALTH|2] healthcheck passed
[logs] 09/15 15:22:26.85 [HEALTH|2] Exit status 0
[logs] 09/15 15:22:27.09 [APP|1] Successfully created container
[logs] 09/15 15:22:27.37 [APP|2] LATTICE-TEST-APP. Says Hello Lattice User. on index: 2
[logs] 09/15 15:22:27.43 [APP|1] {"timestamp":"1442344947.438545227","source":"lattice-app","message":"lattice-app.lattice-app.starting","log_level":1,"data":{"ports":["8080"]}}
[logs] 09/15 15:22:27.44 [APP|1] {"timestamp":"1442344947.439285040","source":"lattice-app","message":"lattice-app.lattice-app.up","log_level":1,"data":{"port":"8080"}}
[logs] 09/15 15:22:27.55 [APP|1] {"timestamp":"1442344947.558669329","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[logs] 09/15 15:22:27.68 [APP|0] LATTICE-TEST-APP. Says Hello Lattice User. on index: 0
.[logs] 09/15 15:22:27.94 [HEALTH|1] healthcheck passed
[logs] 09/15 15:22:27.94 [HEALTH|1] Exit status 0
[logs] 09/15 15:22:28.36 [APP|2] LATTICE-TEST-APP. Says Hello Lattice User. on index: 2
[logs] 09/15 15:22:28.44 [APP|1] LATTICE-TEST-APP. Says Hello Lattice User. on index: 1
[logs] 09/15 15:22:28.68 [APP|0] LATTICE-TEST-APP. Says Hello Lattice User. on index: 0
[scale] App Scaled Successfully
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62256 x_forwarded_for:"192.168.11.1" vcap_request_id:827a083e-19b5-42cf-5fe1-8d50d06e3265 response_time:0.003991809 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62272 x_forwarded_for:"192.168.11.1" vcap_request_id:0cfe9367-2506-442d-5c1e-097f3f01ab22 response_time:0.001449144 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62276 x_forwarded_for:"192.168.11.1" vcap_request_id:c54e9107-e242-4940-5ef8-db3bc3a9c6b0 response_time:0.001563274 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62278 x_forwarded_for:"192.168.11.1" vcap_request_id:7c34df90-d85f-48a5-4f2e-7e61f26d43a3 response_time:0.002064905 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62275 x_forwarded_for:"192.168.11.1" vcap_request_id:41020577-d9c6-4a4d-758c-a89283b03bac response_time:0.002233894 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62274 x_forwarded_for:"192.168.11.1" vcap_request_id:654ccbef-359f-45e1-68ac-0669c00e13e8 response_time:0.002080867 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62277 x_forwarded_for:"192.168.11.1" vcap_request_id:961b2da1-2b81-4c3e-5074-1a50e596ed5c response_time:0.003450064 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.79 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62273 x_forwarded_for:"192.168.11.1" vcap_request_id:b41f8ece-f172-443b-51a9-4fb63b9fbb8b response_time:0.004805734 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62275 x_forwarded_for:"192.168.11.1" vcap_request_id:4323b0e8-61e0-4a16-6d2f-9dbefdd1b6cb response_time:0.002499525 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62278 x_forwarded_for:"192.168.11.1" vcap_request_id:c113a58c-6979-4e2d-617b-dd8467ab1aae response_time:0.002635434 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62276 x_forwarded_for:"192.168.11.1" vcap_request_id:a2017b57-7a70-4718-537c-b953b1312d0b response_time:0.002381810 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62272 x_forwarded_for:"192.168.11.1" vcap_request_id:92184eb2-91c2-4c76-4b8f-3bd4bdba57ac response_time:0.003556576 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62277 x_forwarded_for:"192.168.11.1" vcap_request_id:5c938934-4711-4ad0-480b-b50a16db4011 response_time:0.003871816 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[logs] 09/15 15:22:28.80 [RTR|0] lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io - [15/09/2015:19:22:28 +0000] "GET /index HTTP/1.1" 200 0 1 "-" "Go 1.1 package http" 192.168.11.1:62256 x_forwarded_for:"192.168.11.1" vcap_request_id:16998aa9-ed2b-4097-751c-e1c9fd5e6339 response_time:0.006888669 app_id:lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[logs]
[test] Attempting to remove app lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35
[remove] Removing lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35...
[test] Polling for the appRoute lattice-test-app-7f8f0c44-1c7e-4804-79ec-463769513a35.192.168.11.11.xip.io
•
------------------------------
Lattice docker when desiring a docker-based LRP
should run a docker app using metadata from Docker Hub
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:144
[test] Attempting to create lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083
[create] No port specified, image metadata did not contain exposed ports. Defaulting to 8080.
[create] No working directory specified, using working directory from the image metadata...
[create] Monitoring the app on port 8080...
[create] No start command specified, using start command from the image metadata...
[create] Start command is:
[create] /lattice-app
[create] Creating App: lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083
[create] .09/15 15:22:31.67 [APP|0] Creating container
[create] .09/15 15:22:32.87 [APP|0] Successfully created container
[create] 09/15 15:22:33.20 [APP|0] {"timestamp":"1442344953.203289509","source":"lattice-app","message":"lattice-app.lattice-app.starting","log_level":1,"data":{"ports":["8080"]}}
[create] 09/15 15:22:33.20 [APP|0] {"timestamp":"1442344953.203790188","source":"lattice-app","message":"lattice-app.lattice-app.up","log_level":1,"data":{"port":"8080"}}
[create] 09/15 15:22:33.32 [APP|0] {"timestamp":"1442344953.328067541","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[create] .09/15 15:22:33.69 [HEALTH|0] healthcheck passed
[create] 09/15 15:22:33.70 [HEALTH|0] Exit status 0
[create] 09/15 15:22:34.20 [APP|0] Lattice-app. Says Hello. on index: 0
[create]
[create] lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083 is now running.
[create] App is reachable at:
[create] http://lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083.192.168.11.11.xip.io
[create] http://lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083-8080.192.168.11.11.xip.io
[test] Yay! Created lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083
[test] Polling for the appRoute lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083.192.168.11.11.xip.io
[test] Attempting to remove app lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083
[remove] Removing lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083...
[test] Polling for the appRoute lattice-test-app-1177525d-19d1-4ad3-4eeb-e3298f587083.192.168.11.11.xip.io
•
------------------------------
Lattice docker when desiring a docker-based LRP when `--run-as-root` is passed as an argument to `ltc create`
should run the app as the root user
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:159
[test] Attempting to create lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a
[create] No port specified, image metadata did not contain exposed ports. Defaulting to 8080.
[create] No working directory specified, using working directory from the image metadata...
[create] Monitoring the app on port 8080...
[create] No start command specified, using start command from the image metadata...
[create] Start command is:
[create] /lattice-app
[create] Creating App: lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a
[create] .09/15 15:22:38.34 [APP|0] Creating container
[create] .09/15 15:22:39.47 [APP|0] Successfully created container
[create] 09/15 15:22:39.81 [APP|0] {"timestamp":"1442344959.811108589","source":"lattice-app","message":"lattice-app.lattice-app.starting","log_level":1,"data":{"ports":["8080"]}}
[create] 09/15 15:22:39.81 [APP|0] {"timestamp":"1442344959.811601877","source":"lattice-app","message":"lattice-app.lattice-app.up","log_level":1,"data":{"port":"8080"}}
[create] 09/15 15:22:39.94 [APP|0] {"timestamp":"1442344959.944452763","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[create] 09/15 15:22:40.30 [HEALTH|0] healthcheck passed
[create] 09/15 15:22:40.30 [HEALTH|0] Exit status 0
[create]
[create] lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a is now running.
[create] App is reachable at:
[create] http://lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a.192.168.11.11.xip.io
[create] http://lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a-8080.192.168.11.11.xip.io
[test] Yay! Created lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a
[test] Polling for the appRoute lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a.192.168.11.11.xip.io
[test] Attempting to remove app lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a
[remove] Removing lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a...
[test] Polling for the appRoute lattice-test-app-da8cf116-d5bb-4472-6445-2ccf5dc8b40a.192.168.11.11.xip.io
•
------------------------------
Lattice docker when desiring a docker-based LRP with tcp routes
should run a docker app exposing tcp routes
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:186
[test] Attempting to create lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[create] No port specified, using exposed ports from the image metadata.
[create] Exposed Ports: 5222
[create] No working directory specified, using working directory from the image metadata...
[create] Monitoring the app on port 5222...
[create] No start command specified, using start command from the image metadata...
[create] Start command is:
[create] /bin/sh -c /bin/nc -l -l -p 5222 -e /bin/yes
[create] Creating App: lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[create] .09/15 15:22:44.88 [APP|0] Creating container
[create] ..09/15 15:22:47.81 [APP|0] Successfully created container
[create] .09/15 15:22:48.25 [APP|0] {"timestamp":"1442344968.251622677","source":"sshd","message":"sshd.started","log_level":1,"data":{}}
[create] 09/15 15:22:48.62 [HEALTH|0] healthcheck passed
[create] 09/15 15:22:48.63 [HEALTH|0] Exit status 0
[create]
[create] lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92 is now running.
[create] App is reachable at:
[create] 192.168.11.11.xip.io:53977
[test] Yay! Created lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[test] Connection to 192.168.11.11.xip.io : 53977
STEP: Updating the routes
[test] Attempting to update lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[update] Updating lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92 routes. You can check this app's current routes by running 'ltc status lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92'
[test] Yay! updated lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[test] Connection to 192.168.11.11.xip.io : 53978
[test] Attempting to remove app lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92
[remove] Removing lattice-test-app-9c60596d-0917-45a4-67a0-740cf6de6b92...
•
------------------------------
Lattice droplets
builds, lists and launches a droplet
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:244
STEP: checking out lattice-app from github
[test] Attempting to clone https://github.com/cloudfoundry-samples/lattice-app.git to /var/folders/jd/g2_v29t5471g66fl5h03mj0r0000gn/T/repo202094246
[git-clone] Cloning into '/var/folders/jd/g2_v29t5471g66fl5h03mj0r0000gn/T/repo202094246'...
[test] Cloned https://github.com/cloudfoundry-samples/lattice-app.git into /var/folders/jd/g2_v29t5471g66fl5h03mj0r0000gn/T/repo202094246
STEP: launching a build task
[test] Submitting build of droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa with buildpack https://github.com/cloudfoundry/go-buildpack.git
[build-droplet] Uploading application bits...
[build-droplet] Uploaded.
[build-droplet] Submitted build of droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa
[build-droplet] 09/15 15:22:51.83 [BUILD|0] Creating container
[build-droplet] 09/15 15:23:06.75 [BUILD|0] Successfully created container
[build-droplet] 09/15 15:23:12.57 [BUILD|0] Deleted http://192.168.11.11.xip.io:8444/blobs/droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa/bits.zip.
[build-droplet] 09/15 15:23:12.58 [BUILD|0] Exit status 0
[build-droplet] 09/15 15:23:12.59 [BUILD|0] Exit status 0
[build-droplet] 09/15 15:23:13.45 [BUILD|0] Failed to clone git repository at https://github.com/cloudfoundry/go-buildpack.git
[build-droplet] 09/15 15:23:13.45 [BUILD|0] Exit status 1
[build-droplet] Build failed: Exited with status 1
[test] Attempting to remove app running-droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa
[remove] Removing running-droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa...
[remove] Error stopping running-droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa: running-droplet-9e223d63-c5c0-4bfe-4e50-e08f5bcaebaa is not started.
• Failure [22.469 seconds]
Lattice
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:246
droplets
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:245
builds, lists and launches a droplet [It]
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:244
No future change is possible. Bailing out early after 21.735s.
Expected
<int>: 14
to match exit code:
<int>: 0
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:506
------------------------------
Summarizing 1 Failure:
[Fail] Lattice droplets [It] builds, lists and launches a droplet
/tmp/build/6ab27078-648c-411d-6b7c-b21706a7cd5f/go/src/github.com/cloudfoundry-incubator/lattice/ltc/cluster_test/cluster_test_runner.go:506
Ran 5 of 5 Specs in 60.830 seconds
FAIL! -- 4 Passed | 1 Failed | 0 Pending | 0 Skipped %
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment