[20:04:17.298] New invocation is queued and will start shortly
[20:04:18.391] Starting the invocation (attempt 1)
[20:04:18.439] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c6f221182e20eb1f4e71ee7149e294d0f4ae6ef1"
[20:04:18.439] Popped gitiles commit info from properties and tags
[20:04:18.439] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:04:18.440] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:04:18.441] Buildbucket request:
{
"requestId": "9013473695420373792",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c6f221182e20eb1f4e71ee7149e294d0f4ae6ef1",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9013473695420373792"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:04:19.147] Scheduled build:
{
"id": "8848043633443213344",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 7148,
"createdBy": "project:chromium",
"createTime": "2021-05-05T20:04:18.551918Z",
"updateTime": "2021-05-05T20:04:19.077813Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c6f221182e20eb1f4e71ee7149e294d0f4ae6ef1",
"ref": "refs/heads/master"
}
}
}
[20:04:19.147] Task URL: https://cr-buildbucket.appspot.com/build/8848043633443213344
[20:04:19.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:2:0) after 5m35s
[20:04:24.664] Received PubSub notification, asking Buildbucket for the build status
[20:04:24.700] Build status: STARTED
[20:09:54.144] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:2:0)
[20:09:54.171] Build status: STARTED
[20:09:54.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:4:0) after 5m27s
[20:15:21.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:4:0)
[20:15:21.238] Build status: STARTED
[20:15:21.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:5:0) after 6m26s
[20:21:47.256] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:5:0)
[20:21:47.288] Build status: STARTED
[20:21:47.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:6:0) after 7m56s
[20:29:43.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:6:0)
[20:29:43.420] Build status: STARTED
[20:29:43.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:7:0) after 8m28s
[20:38:11.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:7:0)
[20:38:11.470] Build status: STARTED
[20:38:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:8:0) after 1m27s
[20:39:38.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:8:0)
[20:39:38.652] Build status: STARTED
[20:39:38.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:9:0) after 1m57s
[20:41:35.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:9:0)
[20:41:35.763] Build status: STARTED
[20:41:35.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:10:0) after 1m43s
[20:43:18.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:10:0)
[20:43:18.949] Build status: STARTED
[20:43:18.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:11:0) after 4m10s
[20:47:28.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:11:0)
[20:47:28.968] Build status: STARTED
[20:47:28.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:12:0) after 9m6s
[20:56:34.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:12:0)
[20:56:35.018] Build status: STARTED
[20:56:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:13:0) after 3m45s
[21:00:20.143] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:13:0)
[21:00:20.171] Build status: STARTED
[21:00:20.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:14:0) after 9m52s
[21:10:12.223] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:14:0)
[21:10:12.255] Build status: STARTED
[21:10:12.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:15:0) after 9m22s
[21:19:34.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:15:0)
[21:19:34.667] Build status: STARTED
[21:19:34.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:16:0) after 9m36s
[21:29:10.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:16:0)
[21:29:10.964] Build status: STARTED
[21:29:10.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:17:0) after 4m26s
[21:33:37.132] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:17:0)
[21:33:37.166] Build status: STARTED
[21:33:37.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:18:0) after 1m12s
[21:34:49.323] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:18:0)
[21:34:49.365] Build status: STARTED
[21:34:49.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:19:0) after 3m5s
[21:37:54.337] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:19:0)
[21:37:54.370] Build status: STARTED
[21:37:54.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:20:0) after 5m22s
[21:43:16.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:20:0)
[21:43:16.530] Build status: STARTED
[21:43:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:21:0) after 6m36s
[21:49:52.674] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:21:0)
[21:49:52.702] Build status: STARTED
[21:49:52.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:22:0) after 6m21s
[21:56:13.920] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:22:0)
[21:56:13.950] Build status: STARTED
[21:56:13.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:23:0) after 6m50s
[22:03:04.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:23:0)
[22:03:04.236] Build status: STARTED
[22:03:04.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:24:0) after 9m50s
[22:12:54.266] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:24:0)
[22:12:54.294] Build status: STARTED
[22:12:54.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:25:0) after 3m42s
[22:16:36.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:25:0)
[22:16:36.487] Build status: STARTED
[22:16:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:26:0) after 5m30s
[22:22:06.603] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:26:0)
[22:22:06.628] Build status: STARTED
[22:22:06.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:27:0) after 5m4s
[22:27:10.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:27:0)
[22:27:10.697] Build status: STARTED
[22:27:10.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:28:0) after 9m27s
[22:36:37.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:28:0)
[22:36:38.003] Build status: STARTED
[22:36:38.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:29:0) after 8m15s
[22:44:53.204] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:29:0)
[22:44:53.231] Build status: STARTED
[22:44:53.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:30:0) after 1m55s
[22:46:48.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:30:0)
[22:46:48.235] Build status: STARTED
[22:46:48.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:31:0) after 8m0s
[22:54:48.254] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:31:0)
[22:54:48.282] Build status: STARTED
[22:54:48.282] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:32:0) after 8m40s
[23:03:28.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:32:0)
[23:03:28.375] Build status: STARTED
[23:03:28.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:33:0) after 4m55s
[23:08:23.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:33:0)
[23:08:23.538] Build status: STARTED
[23:08:23.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:34:0) after 1m59s
[23:10:22.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:34:0)
[23:10:22.651] Build status: STARTED
[23:10:22.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:35:0) after 8m58s
[23:19:20.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:35:0)
[23:19:20.832] Build status: STARTED
[23:19:20.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:36:0) after 1m27s
[23:20:47.915] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:36:0)
[23:20:47.960] Build status: STARTED
[23:20:47.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:37:0) after 3m59s
[23:24:46.959] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:37:0)
[23:24:46.989] Build status: STARTED
[23:24:46.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:38:0) after 1m35s
[23:26:22.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:38:0)
[23:26:22.035] Build status: STARTED
[23:26:22.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:39:0) after 2m7s
[23:28:29.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:39:0)
[23:28:29.349] Build status: STARTED
[23:28:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:40:0) after 1m53s
[23:30:22.462] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:40:0)
[23:30:22.492] Build status: STARTED
[23:30:22.492] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:41:0) after 7m26s
[23:37:48.690] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:41:0)
[23:37:48.716] Build status: STARTED
[23:37:48.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:42:0) after 8m55s
[23:46:43.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:42:0)
[23:46:43.850] Build status: STARTED
[23:46:43.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:43:0) after 7m2s
[23:53:45.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:43:0)
[23:53:45.903] Build status: STARTED
[23:53:45.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:44:0) after 2m48s
[23:56:33.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:44:0)
[23:56:33.958] Build status: STARTED
[23:56:33.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:45:0) after 6m38s
[00:03:12.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:45:0)
[00:03:12.227] Build status: STARTED
[00:03:12.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:46:0) after 7m48s
[00:11:00.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:46:0)
[00:11:00.592] Build status: STARTED
[00:11:00.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:47:0) after 6m58s
[00:17:58.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:47:0)
[00:17:58.637] Build status: STARTED
[00:17:58.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:48:0) after 4m33s
[00:22:31.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:48:0)
[00:22:31.690] Build status: STARTED
[00:22:31.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:49:0) after 5m8s
[00:27:39.715] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:49:0)
[00:27:39.742] Build status: STARTED
[00:27:39.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:50:0) after 1m36s
[00:29:15.821] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:50:0)
[00:29:15.850] Build status: STARTED
[00:29:15.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:51:0) after 9m55s
[00:39:10.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:51:0)
[00:39:10.948] Build status: STARTED
[00:39:10.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:52:0) after 5m14s
[00:44:25.004] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:52:0)
[00:44:25.047] Build status: STARTED
[00:44:25.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:53:0) after 8m43s
[00:53:08.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:53:0)
[00:53:08.253] Build status: STARTED
[00:53:08.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:54:0) after 6m7s
[00:59:15.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:54:0)
[00:59:15.310] Build status: STARTED
[00:59:15.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:55:0) after 6m39s
[01:05:54.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:55:0)
[01:05:54.363] Build status: STARTED
[01:05:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:56:0) after 8m42s
[01:14:36.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:56:0)
[01:14:36.431] Build status: STARTED
[01:14:36.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:57:0) after 5m13s
[01:19:49.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:57:0)
[01:19:49.519] Build status: STARTED
[01:19:49.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:58:0) after 4m12s
[01:24:01.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:58:0)
[01:24:01.636] Build status: STARTED
[01:24:01.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:59:0) after 1m4s
[01:25:05.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:59:0)
[01:25:05.773] Build status: STARTED
[01:25:05.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:60:0) after 5m48s
[01:30:53.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:60:0)
[01:30:53.984] Build status: STARTED
[01:30:53.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:61:0) after 1m49s
[01:32:43.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:61:0)
[01:32:43.035] Build status: STARTED
[01:32:43.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:62:0) after 4m20s
[01:37:03.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:62:0)
[01:37:03.099] Build status: STARTED
[01:37:03.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:63:0) after 5m55s
[01:42:58.138] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:63:0)
[01:42:58.177] Build status: STARTED
[01:42:58.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:64:0) after 1m1s
[01:43:59.248] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:64:0)
[01:43:59.275] Build status: STARTED
[01:43:59.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:65:0) after 4m27s
[01:48:26.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:65:0)
[01:48:26.279] Build status: STARTED
[01:48:26.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:66:0) after 4m36s
[01:53:02.299] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:66:0)
[01:53:02.352] Build status: STARTED
[01:53:02.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:67:0) after 5m20s
[01:58:22.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:67:0)
[01:58:22.581] Build status: STARTED
[01:58:22.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:68:0) after 2m15s
[02:00:37.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:68:0)
[02:00:37.760] Build status: STARTED
[02:00:37.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:69:0) after 8m41s
[02:09:18.850] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:69:0)
[02:09:18.879] Build status: STARTED
[02:09:18.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:70:0) after 4m23s
[02:13:41.902] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:70:0)
[02:13:41.929] Build status: STARTED
[02:13:41.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:71:0) after 6m40s
[02:20:22.053] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:71:0)
[02:20:22.084] Build status: STARTED
[02:20:22.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:72:0) after 1m36s
[02:21:58.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:72:0)
[02:21:58.143] Build status: STARTED
[02:21:58.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:73:0) after 9m2s
[02:31:00.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:73:0)
[02:31:00.377] Build status: STARTED
[02:31:00.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:74:0) after 9m25s
[02:40:25.497] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:74:0)
[02:40:25.528] Build status: STARTED
[02:40:25.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:75:0) after 1m18s
[02:41:43.685] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:75:0)
[02:41:43.739] Build status: STARTED
[02:41:43.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:76:0) after 1m33s
[02:43:16.870] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:76:0)
[02:43:16.906] Build status: STARTED
[02:43:16.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:77:0) after 7m6s
[02:50:22.939] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:77:0)
[02:50:22.974] Build status: STARTED
[02:50:22.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:78:0) after 3m21s
[02:53:43.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:78:0)
[02:53:44.024] Build status: STARTED
[02:53:44.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:79:0) after 6m12s
[02:59:56.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:79:0)
[02:59:56.030] Build status: STARTED
[02:59:56.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:80:0) after 8m15s
[03:08:11.120] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:80:0)
[03:08:11.165] Build status: STARTED
[03:08:11.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:81:0) after 3m27s
[03:11:38.290] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:81:0)
[03:11:38.331] Build status: STARTED
[03:11:38.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:82:0) after 4m44s
[03:16:22.404] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:82:0)
[03:16:22.432] Build status: STARTED
[03:16:22.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:83:0) after 6m48s
[03:23:10.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:83:0)
[03:23:10.501] Build status: STARTED
[03:23:10.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:84:0) after 8m10s
[03:31:20.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:84:0)
[03:31:20.589] Build status: STARTED
[03:31:20.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:85:0) after 5m6s
[03:36:26.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:85:0)
[03:36:26.895] Build status: STARTED
[03:36:26.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:86:0) after 3m52s
[03:40:18.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:86:0)
[03:40:18.976] Build status: STARTED
[03:40:18.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:87:0) after 1m57s
[03:42:15.998] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:87:0)
[03:42:16.027] Build status: STARTED
[03:42:16.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:88:0) after 5m49s
[03:48:05.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:88:0)
[03:48:05.459] Build status: STARTED
[03:48:05.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:89:0) after 9m27s
[03:57:32.557] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:89:0)
[03:57:32.595] Build status: STARTED
[03:57:32.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:90:0) after 5m36s
[04:03:08.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:90:0)
[04:03:08.819] Build status: STARTED
[04:03:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:91:0) after 2m38s
[04:05:46.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:91:0)
[04:05:46.883] Build status: STARTED
[04:05:46.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:92:0) after 9m16s
[04:15:02.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:92:0)
[04:15:03.028] Build status: STARTED
[04:15:03.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:93:0) after 8m3s
[04:23:06.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:93:0)
[04:23:06.077] Build status: STARTED
[04:23:06.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:94:0) after 5m46s
[04:28:52.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:94:0)
[04:28:52.159] Build status: STARTED
[04:28:52.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:95:0) after 7m23s
[04:36:15.178] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:95:0)
[04:36:15.208] Build status: STARTED
[04:36:15.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:96:0) after 1m43s
[04:37:58.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:96:0)
[04:37:58.265] Build status: STARTED
[04:37:58.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:97:0) after 9m49s
[04:47:47.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:97:0)
[04:47:47.358] Build status: STARTED
[04:47:47.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:98:0) after 8m46s
[04:56:33.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:98:0)
[04:56:33.835] Build status: STARTED
[04:56:33.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:99:0) after 8m34s
[05:05:07.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:99:0)
[05:05:07.994] Build status: STARTED
[05:05:07.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:100:0) after 8m47s
[05:13:55.169] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:100:0)
[05:13:55.204] Build status: STARTED
[05:13:55.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:101:0) after 7m7s
[05:21:02.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:101:0)
[05:21:02.366] Build status: STARTED
[05:21:02.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9013473695420373792:102:0) after 5m39s
[05:22:43.850] Received PubSub notification, asking Buildbucket for the build status
[05:22:43.877] Build:
{
"id": "8848043633443213344",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 7148,
"createdBy": "project:chromium",
"createTime": "2021-05-05T20:04:18.551918Z",
"startTime": "2021-05-05T20:04:23.905436Z",
"endTime": "2021-05-06T05:22:43.607191709Z",
"updateTime": "2021-05-06T05:22:43.607596613Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c6f221182e20eb1f4e71ee7149e294d0f4ae6ef1",
"ref": "refs/heads/master"
}
}
}
[05:22:43.877] Invocation finished in 9h18m26.595368551s with status FAILED