Activity log for bug #1903557

Date Who What changed Old value New value Message
2020-11-09 16:23:27 Jason Hobbs bug added bug
2020-11-09 16:23:55 Jason Hobbs description on 2.9rc2, enable-ha failed with the two secondary nodes failing to become ready. They installed quickly and booted up, but in machine log we have this repeated: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/manifold.go:97: [49da11] "machine-2" cannot open api 2020-11-09 15:59:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.004401573s 2020-11-09 15:59:18 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 15:59:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60772->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 15:59:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 15:59:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 15:59:49 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:00:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.005996788s 2020-11-09 16:00:18 DEBUG juju.mongo open.go:174 dialled mongodb server at "127.0.0.1:37017" 2020-11-09 16:00:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60768->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 16:00:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 16:00:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:03 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:08 DEBUG juju.worker.apicaller connect.go:115 connecting with current password 2020-11-09 16:01:08 DEBUG juju.api apiclient.go:760 looked up localhost -> [127.0.0.1] 2020-11-09 16:01:08 DEBUG juju.worker.apicaller connect.go:155 [49da11] failed to connect 2020-11-09 16:01:08 DEBUG juju.worker.dependency engine.go:598 "api-caller" manifold worker stopped: [49da11] "machine-2" cannot open api: unable to connect to API: dial tcp 127.0.0.1:17070: connect: connection refused 2020-11-09 16:01:08 ERROR juju.worker.dependency engine.go:671 "api-caller" manifold worker returned unexpected error: [49da11] "machine-2" cannot open api: unable to connect to API: dial tcp 127.0.0.1:17070: connect: connection refused 2020-11-09 16:01:08 DEBUG juju.worker.dependency engine.go:673 stack trace: dial tcp 127.0.0.1:17070: connect: connection refused /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:691: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:1111: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:1086: unable to connect to API /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:982: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:637: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:215: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/connect.go:156: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/connect.go:211: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/manifold.go:97: [49da11] "machine-2" cannot open api 2020-11-09 16:01:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.006181644s 2020-11-09 16:01:19 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60786->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 16:01:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 16:01:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:49 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout on 2.9rc2, enable-ha failed with the two secondary nodes failing to become ready. They installed quickly and booted up, but in machine log we have this repeated: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/manifold.go:97: [49da11] "machine-2" cannot open api 2020-11-09 15:59:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.004401573s 2020-11-09 15:59:18 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 15:59:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60772->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 15:59:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 15:59:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 15:59:49 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:00:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.005996788s 2020-11-09 16:00:18 DEBUG juju.mongo open.go:174 dialled mongodb server at "127.0.0.1:37017" 2020-11-09 16:00:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60768->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 16:00:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 16:00:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:03 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:08 DEBUG juju.worker.apicaller connect.go:115 connecting with current password 2020-11-09 16:01:08 DEBUG juju.api apiclient.go:760 looked up localhost -> [127.0.0.1] 2020-11-09 16:01:08 DEBUG juju.worker.apicaller connect.go:155 [49da11] failed to connect 2020-11-09 16:01:08 DEBUG juju.worker.dependency engine.go:598 "api-caller" manifold worker stopped: [49da11] "machine-2" cannot open api: unable to connect to API: dial tcp 127.0.0.1:17070: connect: connection refused 2020-11-09 16:01:08 ERROR juju.worker.dependency engine.go:671 "api-caller" manifold worker returned unexpected error: [49da11] "machine-2" cannot open api: unable to connect to API: dial tcp 127.0.0.1:17070: connect: connection refused 2020-11-09 16:01:08 DEBUG juju.worker.dependency engine.go:673 stack trace: dial tcp 127.0.0.1:17070: connect: connection refused /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:691: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:1111: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:1086: unable to connect to API /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:982: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:637: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/api/apiclient.go:215: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/connect.go:156: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/connect.go:211: /home/jenkins/workspace/BuildJuju-amd64/_build/src/github.com/juju/juju/worker/apicaller/manifold.go:97: [49da11] "machine-2" cannot open api 2020-11-09 16:01:18 INFO juju.state.allwatcher allwatcher.go:1791 allwatcher loaded for model "49da1147-a806-4aa2-837f-8ca499125bfc" in 1m0.006181644s 2020-11-09 16:01:19 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:19 ERROR juju.worker.modelcache worker.go:366 watcher error: error loading entities for model 49da1147-a806-4aa2-837f-8ca499125bfc: loading subsidiary collections: cache instance data: cannot read all instance data: read tcp 253.253.0.1:60786->253.14.0.1:37017: i/o timeout, getting new watcher 2020-11-09 16:01:33 DEBUG juju.mongo open.go:174 dialled mongodb server at "253.14.0.1:37017" 2020-11-09 16:01:48 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout 2020-11-09 16:01:49 DEBUG juju.mongo open.go:160 mongodb connection failed, will retry: dial tcp 10.244.32.182:37017: i/o timeout Example run: https://solutions.qa.canonical.com/testruns/testRun/8c61d24a-f199-46f8-ae05-954372e6158e
2020-11-09 21:40:40 Pen Gale juju: milestone 2.9-rc3
2020-11-09 21:41:27 Pen Gale juju: status New Triaged
2020-11-09 21:41:29 Pen Gale juju: importance Undecided High
2020-11-10 05:18:19 Ian Booth juju: status Triaged In Progress
2020-11-10 05:18:23 Ian Booth juju: assignee Ian Booth (wallyworld)
2020-11-11 00:48:04 Ian Booth juju: status In Progress Fix Committed
2020-11-11 00:48:07 Ian Booth juju: milestone 2.9-rc3 2.8.7
2020-11-12 16:44:28 John A Meinel nominated for series juju/2.8
2020-11-12 16:44:28 John A Meinel bug task added juju/2.8
2020-11-12 16:44:36 John A Meinel juju/2.8: status New Fix Committed
2020-11-12 16:44:38 John A Meinel juju/2.8: importance Undecided High
2020-11-12 16:44:50 John A Meinel juju/2.8: assignee Ian Booth (wallyworld)
2020-11-12 16:44:53 John A Meinel juju/2.8: milestone 2.8.7
2020-11-12 16:44:56 John A Meinel juju: milestone 2.8.7 2.9-rc3
2020-12-14 01:18:40 Canonical Juju QA Bot juju/2.8: status Fix Committed Fix Released
2021-04-28 13:32:06 Joseph Phillips juju: status Fix Committed Fix Released