[21:43:55.011] New invocation is queued and will start shortly
[21:43:56.140] Starting the invocation (attempt 1)
[21:43:56.180] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5f069ed7f5a6490dda50369dcd153e4993ffd346"
[21:43:56.180] Popped gitiles commit info from properties and tags
[21:43:56.180] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:56.180] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:56.180] Buildbucket request:
{
"requestId": "8993989079559832032",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f069ed7f5a6490dda50369dcd153e4993ffd346",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8993989079559832032"
},
{
"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"
}
}
[21:43:56.807] Scheduled build:
{
"id": "8828559017586503761",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8384,
"createdBy": "project:chromium",
"createTime": "2021-12-06T21:43:56.258771501Z",
"updateTime": "2021-12-06T21:43:56.258771501Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f069ed7f5a6490dda50369dcd153e4993ffd346",
"ref": "refs/heads/main"
}
}
}
[21:43:56.807] Task URL: https://cr-buildbucket.appspot.com/build/8828559017586503761
[21:43:56.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:2:0) after 2m48s
[21:46:44.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:2:0)
[21:46:45.006] Build status: SCHEDULED
[21:46:45.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:3:0) after 8m11s
[21:50:00.622] Received PubSub notification, asking Buildbucket for the build status
[21:50:00.650] Build status: STARTED
[21:54:56.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:3:0)
[21:54:56.064] Build status: STARTED
[21:54:56.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:5:0) after 4m17s
[21:59:13.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:5:0)
[21:59:13.424] Build status: STARTED
[21:59:13.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:6:0) after 4m33s
[22:03:46.447] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:6:0)
[22:03:46.504] Build status: STARTED
[22:03:46.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:7:0) after 7m36s
[22:11:22.501] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:7:0)
[22:11:22.535] Build status: STARTED
[22:11:22.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:8:0) after 1m6s
[22:12:28.610] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:8:0)
[22:12:28.650] Build status: STARTED
[22:12:28.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:9:0) after 2m40s
[22:15:08.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:9:0)
[22:15:08.959] Build status: STARTED
[22:15:08.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:10:0) after 4m25s
[22:19:34.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:10:0)
[22:19:34.200] Build status: STARTED
[22:19:34.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:11:0) after 1m14s
[22:20:48.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:11:0)
[22:20:48.527] Build status: STARTED
[22:20:48.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:12:0) after 6m38s
[22:27:26.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:12:0)
[22:27:26.580] Build status: STARTED
[22:27:26.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:13:0) after 8m35s
[22:36:01.706] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:13:0)
[22:36:01.734] Build status: STARTED
[22:36:01.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:14:0) after 1m4s
[22:37:06.357] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:14:0)
[22:37:06.386] Build status: STARTED
[22:37:06.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:15:0) after 8m46s
[22:45:52.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:15:0)
[22:45:52.656] Build status: STARTED
[22:45:52.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:16:0) after 3m33s
[22:49:25.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:16:0)
[22:49:25.717] Build status: STARTED
[22:49:25.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:17:0) after 6m52s
[22:56:18.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:17:0)
[22:56:18.105] Build status: STARTED
[22:56:18.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:18:0) after 6m6s
[23:02:24.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:18:0)
[23:02:24.302] Build status: STARTED
[23:02:24.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:19:0) after 8m1s
[23:10:25.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:19:0)
[23:10:25.372] Build status: STARTED
[23:10:25.372] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:20:0) after 3m4s
[23:13:29.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:20:0)
[23:13:29.466] Build status: STARTED
[23:13:29.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:21:0) after 3m26s
[23:16:55.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:21:0)
[23:16:55.486] Build status: STARTED
[23:16:55.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:22:0) after 5m1s
[23:21:56.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:22:0)
[23:21:56.664] Build status: STARTED
[23:21:56.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:23:0) after 8m4s
[23:30:00.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:23:0)
[23:30:00.744] Build status: STARTED
[23:30:00.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:24:0) after 1m0s
[23:31:00.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:24:0)
[23:31:00.941] Build status: STARTED
[23:31:00.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:25:0) after 2m39s
[23:33:39.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:25:0)
[23:33:40.036] Build status: STARTED
[23:33:40.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:26:0) after 2m0s
[23:35:40.073] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:26:0)
[23:35:40.106] Build status: STARTED
[23:35:40.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:27:0) after 8m50s
[23:44:30.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:27:0)
[23:44:30.168] Build status: STARTED
[23:44:30.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:28:0) after 8m10s
[23:52:40.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:28:0)
[23:52:40.418] Build status: STARTED
[23:52:40.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:29:0) after 9m54s
[00:02:41.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:29:0)
[00:02:41.957] Build status: STARTED
[00:02:41.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:30:0) after 3m11s
[00:05:52.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:30:0)
[00:05:53.057] Build status: STARTED
[00:05:53.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:31:0) after 7m47s
[00:13:40.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:31:0)
[00:13:40.300] Build status: STARTED
[00:13:40.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:32:0) after 9m11s
[00:22:51.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:32:0)
[00:22:51.449] Build status: STARTED
[00:22:51.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:33:0) after 3m37s
[00:26:28.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:33:0)
[00:26:28.563] Build status: STARTED
[00:26:28.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:34:0) after 4m7s
[00:30:35.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:34:0)
[00:30:35.655] Build status: STARTED
[00:30:35.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:35:0) after 9m29s
[00:40:04.796] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:35:0)
[00:40:04.868] Build status: STARTED
[00:40:04.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:36:0) after 2m5s
[00:42:10.259] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:36:0)
[00:42:10.302] Build status: STARTED
[00:42:10.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:37:0) after 8m54s
[00:51:04.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:37:0)
[00:51:04.462] Build status: STARTED
[00:51:04.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:38:0) after 5m51s
[00:56:55.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:38:0)
[00:56:55.870] Build status: STARTED
[00:56:55.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:39:0) after 9m27s
[01:06:23.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:39:0)
[01:06:23.173] Build status: STARTED
[01:06:23.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:40:0) after 1m33s
[01:07:56.203] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:40:0)
[01:07:56.237] Build status: STARTED
[01:07:56.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:41:0) after 6m21s
[01:14:17.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:41:0)
[01:14:17.527] Build status: STARTED
[01:14:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:42:0) after 7m3s
[01:21:20.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:42:0)
[01:21:20.582] Build status: STARTED
[01:21:20.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:43:0) after 4m39s
[01:25:59.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:43:0)
[01:25:59.657] Build status: STARTED
[01:25:59.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:44:0) after 7m40s
[01:33:39.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:44:0)
[01:33:39.680] Build status: STARTED
[01:33:39.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:45:0) after 6m53s
[01:40:32.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:45:0)
[01:40:32.767] Build status: STARTED
[01:40:32.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:46:0) after 5m7s
[01:45:39.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:46:0)
[01:45:39.830] Build status: STARTED
[01:45:39.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:47:0) after 9m48s
[01:55:27.967] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:47:0)
[01:55:28.001] Build status: STARTED
[01:55:28.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:48:0) after 5m23s
[02:00:51.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:48:0)
[02:00:51.295] Build status: STARTED
[02:00:51.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:49:0) after 5m17s
[02:06:08.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:49:0)
[02:06:08.580] Build status: STARTED
[02:06:08.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:50:0) after 2m47s
[02:08:55.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:50:0)
[02:08:55.605] Build status: STARTED
[02:08:55.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:51:0) after 6m5s
[02:15:00.649] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:51:0)
[02:15:00.684] Build status: STARTED
[02:15:00.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:52:0) after 8m52s
[02:23:52.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:52:0)
[02:23:52.749] Build status: STARTED
[02:23:52.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:53:0) after 8m38s
[02:32:30.781] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:53:0)
[02:32:30.835] Build status: STARTED
[02:32:30.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:54:0) after 1m47s
[02:34:18.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:54:0)
[02:34:18.111] Build status: STARTED
[02:34:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:55:0) after 8m11s
[02:42:29.168] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:55:0)
[02:42:29.199] Build status: STARTED
[02:42:29.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:56:0) after 2m8s
[02:44:37.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:56:0)
[02:44:37.726] Build status: STARTED
[02:44:37.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:57:0) after 6m7s
[02:50:44.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:57:0)
[02:50:44.795] Build status: STARTED
[02:50:44.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:58:0) after 1m5s
[02:51:49.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:58:0)
[02:51:49.909] Build status: STARTED
[02:51:49.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:59:0) after 8m48s
[03:00:37.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:59:0)
[03:00:38.003] Build status: STARTED
[03:00:38.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:60:0) after 1m56s
[03:02:34.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:60:0)
[03:02:34.182] Build status: STARTED
[03:02:34.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:61:0) after 4m17s
[03:06:51.228] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:61:0)
[03:06:51.258] Build status: STARTED
[03:06:51.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:62:0) after 3m14s
[03:10:05.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:62:0)
[03:10:05.506] Build status: STARTED
[03:10:05.506] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:63:0) after 1m15s
[03:11:20.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:63:0)
[03:11:20.807] Build status: STARTED
[03:11:20.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:64:0) after 6m20s
[03:17:40.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:64:0)
[03:17:41.021] Build status: STARTED
[03:17:41.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:65:0) after 5m35s
[03:23:16.456] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:65:0)
[03:23:16.493] Build status: STARTED
[03:23:16.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:66:0) after 9m28s
[03:32:44.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:66:0)
[03:32:44.580] Build status: STARTED
[03:32:44.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:67:0) after 9m6s
[03:41:50.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:67:0)
[03:41:50.661] Build status: STARTED
[03:41:50.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:68:0) after 6m12s
[03:48:02.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:68:0)
[03:48:02.749] Build status: STARTED
[03:48:02.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:69:0) after 1m1s
[03:49:03.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:69:0)
[03:49:03.834] Build status: STARTED
[03:49:03.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:70:0) after 3m8s
[03:52:11.939] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:70:0)
[03:52:11.978] Build status: STARTED
[03:52:11.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:71:0) after 7m54s
[04:00:06.008] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:71:0)
[04:00:06.040] Build status: STARTED
[04:00:06.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:72:0) after 1m1s
[04:01:07.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:72:0)
[04:01:07.241] Build status: STARTED
[04:01:07.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:73:0) after 1m44s
[04:02:51.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:73:0)
[04:02:51.370] Build status: STARTED
[04:02:51.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:74:0) after 2m20s
[04:05:11.403] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:74:0)
[04:05:11.440] Build status: STARTED
[04:05:11.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:75:0) after 7m53s
[04:13:04.524] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:75:0)
[04:13:04.567] Build status: STARTED
[04:13:04.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:76:0) after 3m18s
[04:16:22.599] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:76:0)
[04:16:22.653] Build status: STARTED
[04:16:22.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:77:0) after 4m59s
[04:21:21.683] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:77:0)
[04:21:21.720] Build status: STARTED
[04:21:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:78:0) after 7m36s
[04:28:57.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:78:0)
[04:28:57.782] Build status: STARTED
[04:28:57.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:79:0) after 6m54s
[04:35:51.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:79:0)
[04:35:51.843] Build status: STARTED
[04:35:51.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:80:0) after 6m23s
[04:42:14.875] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:80:0)
[04:42:14.911] Build status: STARTED
[04:42:14.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:81:0) after 9m54s
[04:52:09.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:81:0)
[04:52:09.175] Build status: STARTED
[04:52:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:82:0) after 6m40s
[04:58:49.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:82:0)
[04:58:49.334] Build status: STARTED
[04:58:49.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:83:0) after 2m44s
[05:01:34.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:83:0)
[05:01:34.187] Build status: STARTED
[05:01:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:84:0) after 3m37s
[05:05:11.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:84:0)
[05:05:11.291] Build status: STARTED
[05:05:11.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:85:0) after 7m18s
[05:12:29.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:85:0)
[05:12:29.379] Build status: STARTED
[05:12:29.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:86:0) after 9m53s
[05:22:22.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:86:0)
[05:22:22.438] Build status: STARTED
[05:22:22.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:87:0) after 5m29s
[05:27:51.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:87:0)
[05:27:51.522] Build status: STARTED
[05:27:51.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:88:0) after 3m30s
[05:31:21.555] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:88:0)
[05:31:21.667] Build status: STARTED
[05:31:21.667] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:89:0) after 2m25s
[05:33:46.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:89:0)
[05:33:46.818] Build status: STARTED
[05:33:46.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:90:0) after 5m6s
[05:38:52.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:90:0)
[05:38:52.901] Build status: STARTED
[05:38:52.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:91:0) after 7m20s
[05:46:12.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:91:0)
[05:46:13.005] Build status: STARTED
[05:46:13.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:92:0) after 7m51s
[05:54:04.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:92:0)
[05:54:04.091] Build status: STARTED
[05:54:04.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:93:0) after 8m32s
[06:02:36.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:93:0)
[06:02:36.187] Build status: STARTED
[06:02:36.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:94:0) after 7m20s
[06:09:56.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:94:0)
[06:09:56.251] Build status: STARTED
[06:09:56.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:95:0) after 3m58s
[06:13:54.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:95:0)
[06:13:54.313] Build status: STARTED
[06:13:54.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:96:0) after 3m21s
[06:17:15.333] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:96:0)
[06:17:15.361] Build status: STARTED
[06:17:15.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:97:0) after 2m26s
[06:19:41.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:97:0)
[06:19:41.508] Build status: STARTED
[06:19:41.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:98:0) after 2m27s
[06:22:08.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:98:0)
[06:22:08.611] Build status: STARTED
[06:22:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:99:0) after 6m50s
[06:28:58.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:99:0)
[06:28:58.677] Build status: STARTED
[06:28:58.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:100:0) after 1m2s
[06:30:00.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:100:0)
[06:30:00.758] Build status: STARTED
[06:30:00.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:101:0) after 8m34s
[06:38:34.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:101:0)
[06:38:34.819] Build status: STARTED
[06:38:34.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:102:0) after 5m4s
[06:43:38.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:102:0)
[06:43:38.975] Build status: STARTED
[06:43:38.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:103:0) after 1m35s
[06:45:14.145] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:103:0)
[06:45:14.180] Build status: STARTED
[06:45:14.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:104:0) after 7m28s
[06:52:42.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:104:0)
[06:52:42.267] Build status: STARTED
[06:52:42.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:105:0) after 7m49s
[07:00:31.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:105:0)
[07:00:31.359] Build status: STARTED
[07:00:31.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8993989079559832032:106:0) after 7m13s
[07:02:24.213] Received PubSub notification, asking Buildbucket for the build status
[07:02:24.260] Build:
{
"id": "8828559017586503761",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8384,
"createdBy": "project:chromium",
"createTime": "2021-12-06T21:43:56.258771501Z",
"startTime": "2021-12-06T21:49:59.969442Z",
"endTime": "2021-12-07T07:02:23.377638084Z",
"updateTime": "2021-12-07T07:02:23.377638084Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "5f069ed7f5a6490dda50369dcd153e4993ffd346",
"ref": "refs/heads/main"
}
}
}
[07:02:24.260] Invocation finished in 9h18m29.266598313s with status SUCCEEDED