[06:37:54.359] New invocation is queued and will start shortly
[06:37:55.468] Starting the invocation (attempt 1)
[06:37:55.493] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc7e188ed6dd3702c543eff2e780daeece30d389"
[06:37:55.493] Popped gitiles commit info from properties and tags
[06:37:55.493] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:37:55.493] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:37:55.494] Buildbucket request:
{
"requestId": "8898466281277808224",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-official"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7e188ed6dd3702c543eff2e780daeece30d389",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898466281277808224"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-official"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:37:56.071] Scheduled build:
{
"id": "8733036219359034305",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-official"
},
"number": 11858,
"createdBy": "project:chromium",
"createTime": "2024-10-26T06:37:55.559790913Z",
"updateTime": "2024-10-26T06:37:55.559790913Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7e188ed6dd3702c543eff2e780daeece30d389",
"ref": "refs/heads/main"
}
}
}
[06:37:56.071] Task URL: https://cr-buildbucket.appspot.com/build/8733036219359034305
[06:37:56.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:2:0) after 9m54s
[06:37:57.033] Received PubSub notification, asking Buildbucket for the build status
[06:37:57.056] Build status: SCHEDULED
[06:39:39.016] Received PubSub notification, asking Buildbucket for the build status
[06:39:39.039] Build status: STARTED
[06:47:50.198] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:2:0)
[06:47:50.213] Build status: STARTED
[06:47:50.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:5:0) after 6m59s
[06:54:49.310] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:5:0)
[06:54:49.330] Build status: STARTED
[06:54:49.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:6:0) after 5m0s
[06:59:49.342] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:6:0)
[06:59:49.371] Build status: STARTED
[06:59:49.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:7:0) after 4m28s
[07:04:17.609] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:7:0)
[07:04:17.669] Build status: STARTED
[07:04:17.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:8:0) after 9m43s
[07:14:00.661] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:8:0)
[07:14:00.684] Build status: STARTED
[07:14:00.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:9:0) after 4m48s
[07:18:48.752] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:9:0)
[07:18:48.774] Build status: STARTED
[07:18:48.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:10:0) after 1m15s
[07:20:03.793] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:10:0)
[07:20:03.816] Build status: STARTED
[07:20:03.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:11:0) after 8m13s
[07:28:17.012] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:11:0)
[07:28:17.033] Build status: STARTED
[07:28:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:12:0) after 5m32s
[07:33:49.276] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:12:0)
[07:33:49.291] Build status: STARTED
[07:33:49.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:13:0) after 5m46s
[07:39:35.406] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:13:0)
[07:39:35.490] Build status: STARTED
[07:39:35.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:14:0) after 1m6s
[07:40:41.802] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:14:0)
[07:40:41.878] Build status: STARTED
[07:40:41.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:15:0) after 6m21s
[07:47:02.894] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:15:0)
[07:47:02.908] Build status: STARTED
[07:47:02.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:16:0) after 8m17s
[07:55:19.926] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:16:0)
[07:55:20.007] Build status: STARTED
[07:55:20.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:17:0) after 4m15s
[07:59:35.109] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:17:0)
[07:59:35.134] Build status: STARTED
[07:59:35.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:18:0) after 6m2s
[08:05:37.152] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:18:0)
[08:05:37.170] Build status: STARTED
[08:05:37.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:19:0) after 5m33s
[08:11:10.514] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:19:0)
[08:11:10.537] Build status: STARTED
[08:11:10.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:20:0) after 8m34s
[08:19:44.795] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:20:0)
[08:19:44.809] Build status: STARTED
[08:19:44.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:21:0) after 6m54s
[08:26:39.044] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:21:0)
[08:26:39.062] Build status: STARTED
[08:26:39.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:22:0) after 8m38s
[08:35:17.080] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:22:0)
[08:35:17.102] Build status: STARTED
[08:35:17.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:23:0) after 9m43s
[08:45:00.315] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:23:0)
[08:45:00.338] Build status: STARTED
[08:45:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:24:0) after 6m36s
[08:51:36.361] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:24:0)
[08:51:36.379] Build status: STARTED
[08:51:36.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:25:0) after 5m15s
[08:56:51.405] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:25:0)
[08:56:51.429] Build status: STARTED
[08:56:51.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:26:0) after 3m0s
[08:59:51.452] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:26:0)
[08:59:51.485] Build status: STARTED
[08:59:51.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:27:0) after 5m30s
[09:05:21.598] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:27:0)
[09:05:21.615] Build status: STARTED
[09:05:21.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:28:0) after 7m49s
[09:13:10.732] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:28:0)
[09:13:10.805] Build status: STARTED
[09:13:10.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:29:0) after 4m54s
[09:18:04.989] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:29:0)
[09:18:05.007] Build status: STARTED
[09:18:05.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:30:0) after 7m16s
[09:25:21.024] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:30:0)
[09:25:21.072] Build status: STARTED
[09:25:21.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:31:0) after 8m10s
[09:33:31.206] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:31:0)
[09:33:31.231] Build status: STARTED
[09:33:31.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:32:0) after 4m15s
[09:37:46.347] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:32:0)
[09:37:46.365] Build status: STARTED
[09:37:46.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:33:0) after 9m32s
[09:47:18.406] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:33:0)
[09:47:18.423] Build status: STARTED
[09:47:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:34:0) after 9m4s
[09:56:22.469] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:34:0)
[09:56:22.505] Build status: STARTED
[09:56:22.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:35:0) after 2m7s
[09:58:29.614] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:35:0)
[09:58:29.635] Build status: STARTED
[09:58:29.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:36:0) after 4m21s
[10:02:50.667] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:36:0)
[10:02:50.695] Build status: STARTED
[10:02:50.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:37:0) after 9m58s
[10:12:48.823] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:37:0)
[10:12:48.852] Build status: STARTED
[10:12:48.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:38:0) after 3m40s
[10:16:28.887] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:38:0)
[10:16:28.928] Build status: STARTED
[10:16:28.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:39:0) after 5m41s
[10:22:09.944] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:39:0)
[10:22:09.960] Build status: STARTED
[10:22:09.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:40:0) after 1m51s
[10:24:00.977] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:40:0)
[10:24:00.993] Build status: STARTED
[10:24:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:41:0) after 9m12s
[10:33:13.112] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:41:0)
[10:33:13.130] Build status: STARTED
[10:33:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:42:0) after 5m27s
[10:38:40.151] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:42:0)
[10:38:40.169] Build status: STARTED
[10:38:40.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:43:0) after 7m4s
[10:45:44.156] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:43:0)
[10:45:44.241] Build status: STARTED
[10:45:44.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:44:0) after 6m59s
[10:52:43.259] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:44:0)
[10:52:43.298] Build status: STARTED
[10:52:43.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:45:0) after 7m37s
[11:00:20.368] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:45:0)
[11:00:20.385] Build status: STARTED
[11:00:20.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:46:0) after 1m13s
[11:01:33.380] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:46:0)
[11:01:33.436] Build status: STARTED
[11:01:33.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:47:0) after 2m43s
[11:04:16.553] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:47:0)
[11:04:16.570] Build status: STARTED
[11:04:16.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:48:0) after 9m13s
[11:13:29.588] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:48:0)
[11:13:29.657] Build status: STARTED
[11:13:29.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:49:0) after 1m11s
[11:14:40.741] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:49:0)
[11:14:40.769] Build status: STARTED
[11:14:40.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:50:0) after 3m12s
[11:17:52.752] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:50:0)
[11:17:52.770] Build status: STARTED
[11:17:52.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:51:0) after 1m25s
[11:19:17.894] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:51:0)
[11:19:17.912] Build status: STARTED
[11:19:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:52:0) after 4m36s
[11:23:53.992] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:52:0)
[11:23:54.011] Build status: STARTED
[11:23:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:53:0) after 5m12s
[11:29:06.029] Handling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:53:0)
[11:29:06.051] Build status: STARTED
[11:29:06.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:8898466281277808224:54:0) after 5m55s
[11:34:28.832] Received PubSub notification, asking Buildbucket for the build status
[11:34:28.854] Build:
{
"id": "8733036219359034305",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-official"
},
"number": 11858,
"createdBy": "project:chromium",
"createTime": "2024-10-26T06:37:55.559790913Z",
"startTime": "2024-10-26T06:39:38.085223469Z",
"endTime": "2024-10-26T11:34:28.546427733Z",
"updateTime": "2024-10-26T11:34:28.546427733Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7e188ed6dd3702c543eff2e780daeece30d389",
"ref": "refs/heads/main"
}
}
}
[11:34:28.854] Invocation finished in 4h56m34.507910891s with status SUCCEEDED