[16:43:24.509] New invocation is queued and will start shortly
[16:43:26.095] Starting the invocation (attempt 1)
[16:43:26.134] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b378f244a68d6b725887511204fc13482261b3bd"
[16:43:26.134] Popped gitiles commit info from properties and tags
[16:43:26.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:43:26.134] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:43:26.135] Buildbucket request:
{
"requestId": "8869527754064927296",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b378f244a68d6b725887511204fc13482261b3bd",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869527754064927296"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Windows ASan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:43:26.997] Scheduled build:
{
"id": "8704097691647984321",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 59811,
"createdBy": "project:chromium",
"createTime": "2025-09-10T16:43:26.192962179Z",
"updateTime": "2025-09-10T16:43:26.192962179Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b378f244a68d6b725887511204fc13482261b3bd",
"ref": "refs/heads/main"
}
}
}
[16:43:26.997] Task URL: https://cr-buildbucket.appspot.com/build/8704097691647984321
[16:43:26.997] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:2:0) after 3m2s
[16:43:29.308] Received PubSub notification, asking Buildbucket for the build status
[16:43:29.334] Build status: SCHEDULED
[16:43:35.910] Received PubSub notification, asking Buildbucket for the build status
[16:43:35.942] Build status: STARTED
[16:46:29.015] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:2:0)
[16:46:29.040] Build status: STARTED
[16:46:29.040] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:5:0) after 3m46s
[16:50:15.060] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:5:0)
[16:50:15.073] Build status: STARTED
[16:50:15.073] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:6:0) after 9m2s
[16:59:17.138] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:6:0)
[16:59:17.161] Build status: STARTED
[16:59:17.161] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:7:0) after 7m29s
[17:06:46.276] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:7:0)
[17:06:46.292] Build status: STARTED
[17:06:46.292] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:8:0) after 1m1s
[17:07:47.318] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:8:0)
[17:07:47.347] Build status: STARTED
[17:07:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:9:0) after 4m3s
[17:11:50.372] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:9:0)
[17:11:50.401] Build status: STARTED
[17:11:50.401] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:10:0) after 4m43s
[17:16:33.423] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:10:0)
[17:16:33.486] Build status: STARTED
[17:16:33.486] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:11:0) after 1m43s
[17:18:16.559] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:11:0)
[17:18:16.577] Build status: STARTED
[17:18:16.577] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:12:0) after 8m44s
[17:27:00.625] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:12:0)
[17:27:00.642] Build status: STARTED
[17:27:00.642] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:13:0) after 7m52s
[17:34:52.669] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:13:0)
[17:34:52.687] Build status: STARTED
[17:34:52.687] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:14:0) after 5m38s
[17:40:30.769] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:14:0)
[17:40:30.790] Build status: STARTED
[17:40:30.790] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:15:0) after 9m53s
[17:50:23.880] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:15:0)
[17:50:23.921] Build status: STARTED
[17:50:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:16:0) after 4m34s
[17:54:57.920] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:16:0)
[17:54:57.940] Build status: STARTED
[17:54:57.940] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:17:0) after 3m5s
[17:58:02.976] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:17:0)
[17:58:03.061] Build status: STARTED
[17:58:03.061] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:18:0) after 8m14s
[18:06:17.110] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:18:0)
[18:06:17.135] Build status: STARTED
[18:06:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:19:0) after 1m34s
[18:07:51.151] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:19:0)
[18:07:51.169] Build status: STARTED
[18:07:51.169] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:20:0) after 6m39s
[18:14:30.261] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:20:0)
[18:14:30.280] Build status: STARTED
[18:14:30.280] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:21:0) after 9m5s
[18:23:35.301] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:21:0)
[18:23:35.372] Build status: STARTED
[18:23:35.372] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:22:0) after 3m40s
[18:27:15.452] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:22:0)
[18:27:15.470] Build status: STARTED
[18:27:15.470] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:23:0) after 2m6s
[18:29:21.583] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:23:0)
[18:29:21.599] Build status: STARTED
[18:29:21.599] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:24:0) after 8m55s
[18:38:16.621] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:24:0)
[18:38:16.660] Build status: STARTED
[18:38:16.660] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:25:0) after 7m32s
[18:45:48.679] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:25:0)
[18:45:48.717] Build status: STARTED
[18:45:48.717] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:26:0) after 6m46s
[18:52:34.734] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:26:0)
[18:52:34.756] Build status: STARTED
[18:52:34.756] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:27:0) after 5m25s
[18:57:59.789] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:27:0)
[18:57:59.808] Build status: STARTED
[18:57:59.808] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:28:0) after 1m46s
[18:59:45.823] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:28:0)
[18:59:45.843] Build status: STARTED
[18:59:45.843] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:29:0) after 4m12s
[19:03:57.857] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:29:0)
[19:03:57.878] Build status: STARTED
[19:03:57.878] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:30:0) after 4m42s
[19:08:39.886] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:30:0)
[19:08:39.971] Build status: STARTED
[19:08:39.971] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:31:0) after 9m24s
[19:18:03.989] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:31:0)
[19:18:04.039] Build status: STARTED
[19:18:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:32:0) after 8m59s
[19:27:03.122] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:32:0)
[19:27:03.141] Build status: STARTED
[19:27:03.141] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:33:0) after 8m20s
[19:35:23.165] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:33:0)
[19:35:23.184] Build status: STARTED
[19:35:23.184] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:34:0) after 3m55s
[19:39:18.270] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:34:0)
[19:39:18.411] Build status: STARTED
[19:39:18.411] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:35:0) after 8m41s
[19:47:59.439] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:35:0)
[19:47:59.458] Build status: STARTED
[19:47:59.458] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:36:0) after 7m16s
[19:55:15.479] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:36:0)
[19:55:15.512] Build status: STARTED
[19:55:15.513] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:37:0) after 5m2s
[20:00:17.554] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:37:0)
[20:00:17.592] Build status: STARTED
[20:00:17.593] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:38:0) after 2m9s
[20:02:26.626] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:38:0)
[20:02:26.644] Build status: STARTED
[20:02:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:39:0) after 5m38s
[20:08:04.663] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:39:0)
[20:08:04.682] Build status: STARTED
[20:08:04.682] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:40:0) after 8m9s
[20:16:13.667] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:40:0)
[20:16:13.716] Build status: STARTED
[20:16:13.716] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:41:0) after 6m35s
[20:22:48.846] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:41:0)
[20:22:48.863] Build status: STARTED
[20:22:48.863] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:42:0) after 6m3s
[20:28:51.884] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:42:0)
[20:28:51.910] Build status: STARTED
[20:28:51.911] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:43:0) after 9m2s
[20:37:53.948] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:43:0)
[20:37:53.969] Build status: STARTED
[20:37:53.969] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:44:0) after 5m6s
[20:42:59.986] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:44:0)
[20:43:00.034] Build status: STARTED
[20:43:00.034] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:45:0) after 3m42s
[20:46:42.220] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:45:0)
[20:46:42.237] Build status: STARTED
[20:46:42.237] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:46:0) after 6m1s
[20:52:43.482] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:46:0)
[20:52:43.503] Build status: STARTED
[20:52:43.503] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:47:0) after 3m32s
[20:56:15.523] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:47:0)
[20:56:15.553] Build status: STARTED
[20:56:15.553] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:48:0) after 2m27s
[20:58:42.574] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:48:0)
[20:58:42.590] Build status: STARTED
[20:58:42.591] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:49:0) after 9m45s
[21:08:27.610] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:49:0)
[21:08:27.642] Build status: STARTED
[21:08:27.642] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:50:0) after 2m27s
[21:10:54.696] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:50:0)
[21:10:54.751] Build status: STARTED
[21:10:54.751] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:51:0) after 6m41s
[21:17:35.818] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:51:0)
[21:17:35.843] Build status: STARTED
[21:17:35.843] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:52:0) after 9m1s
[21:26:36.883] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:52:0)
[21:26:36.902] Build status: STARTED
[21:26:36.902] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:53:0) after 5m15s
[21:31:51.962] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:53:0)
[21:31:51.982] Build status: STARTED
[21:31:51.982] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:54:0) after 7m0s
[21:38:52.027] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:54:0)
[21:38:52.082] Build status: STARTED
[21:38:52.082] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:55:0) after 1m34s
[21:40:26.115] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:55:0)
[21:40:26.131] Build status: STARTED
[21:40:26.131] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:56:0) after 4m12s
[21:44:38.216] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:56:0)
[21:44:38.236] Build status: STARTED
[21:44:38.236] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:57:0) after 6m16s
[21:50:54.448] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:57:0)
[21:50:54.558] Build status: STARTED
[21:50:54.558] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8869527754064927296:58:0) after 7m27s
[21:58:03.474] Received PubSub notification, asking Buildbucket for the build status
[21:58:03.510] Build:
{
"id": "8704097691647984321",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 59811,
"createdBy": "project:chromium",
"createTime": "2025-09-10T16:43:26.192962179Z",
"startTime": "2025-09-10T16:43:33.194644146Z",
"endTime": "2025-09-10T21:58:03.217919200Z",
"updateTime": "2025-09-10T21:58:03.217919200Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b378f244a68d6b725887511204fc13482261b3bd",
"ref": "refs/heads/main"
}
}
}
[21:58:03.510] Invocation finished in 5h14m39.007550643s with status SUCCEEDED