[07:27:41.466] New invocation is queued and will start shortly
[07:27:42.502] Starting the invocation (attempt 1)
[07:27:42.521] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9044a030a6ccfe9b7edabf5f484af298f9779ea"
[07:27:42.521] Popped gitiles commit info from properties and tags
[07:27:42.521] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:27:42.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:27:42.522] Buildbucket request:
{
"requestId": "8879347189151685456",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d9044a030a6ccfe9b7edabf5f484af298f9779ea",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879347189151685456"
},
{
"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"
}
}
[07:27:43.488] Scheduled build:
{
"id": "8713917127321400193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 58298,
"createdBy": "project:chromium",
"createTime": "2025-05-25T07:27:42.589806580Z",
"updateTime": "2025-05-25T07:27:42.589806580Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d9044a030a6ccfe9b7edabf5f484af298f9779ea",
"ref": "refs/heads/main"
}
}
}
[07:27:43.489] Task URL: https://cr-buildbucket.appspot.com/build/8713917127321400193
[07:27:43.489] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:2:0) after 2m11s
[07:27:44.570] Received PubSub notification, asking Buildbucket for the build status
[07:27:44.712] Build status: SCHEDULED
[07:27:49.979] Received PubSub notification, asking Buildbucket for the build status
[07:27:50.003] Build status: STARTED
[07:29:54.660] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:2:0)
[07:29:54.720] Build status: STARTED
[07:29:54.720] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:5:0) after 6m44s
[07:36:38.939] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:5:0)
[07:36:38.962] Build status: STARTED
[07:36:38.962] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:6:0) after 3m8s
[07:39:47.193] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:6:0)
[07:39:47.249] Build status: STARTED
[07:39:47.249] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:7:0) after 7m21s
[07:47:08.301] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:7:0)
[07:47:08.319] Build status: STARTED
[07:47:08.319] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:8:0) after 5m19s
[07:52:27.389] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:8:0)
[07:52:27.427] Build status: STARTED
[07:52:27.427] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:9:0) after 7m58s
[08:00:25.444] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:9:0)
[08:00:25.463] Build status: STARTED
[08:00:25.463] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:10:0) after 3m8s
[08:03:33.591] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:10:0)
[08:03:33.617] Build status: STARTED
[08:03:33.617] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:11:0) after 3m12s
[08:06:45.639] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:11:0)
[08:06:45.663] Build status: STARTED
[08:06:45.663] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:12:0) after 9m36s
[08:16:22.138] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:12:0)
[08:16:22.154] Build status: STARTED
[08:16:22.154] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:13:0) after 2m58s
[08:19:20.175] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:13:0)
[08:19:20.199] Build status: STARTED
[08:19:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:14:0) after 1m9s
[08:20:29.228] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:14:0)
[08:20:29.256] Build status: STARTED
[08:20:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:15:0) after 7m32s
[08:28:01.500] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:15:0)
[08:28:01.542] Build status: STARTED
[08:28:01.542] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:16:0) after 5m28s
[08:33:29.568] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:16:0)
[08:33:29.590] Build status: STARTED
[08:33:29.590] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:17:0) after 9m5s
[08:42:34.655] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:17:0)
[08:42:34.683] Build status: STARTED
[08:42:34.683] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:18:0) after 7m40s
[08:50:15.036] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:18:0)
[08:50:15.064] Build status: STARTED
[08:50:15.064] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:19:0) after 3m41s
[08:53:56.229] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:19:0)
[08:53:56.267] Build status: STARTED
[08:53:56.267] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:20:0) after 3m35s
[08:57:31.333] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:20:0)
[08:57:31.350] Build status: STARTED
[08:57:31.350] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:21:0) after 1m31s
[08:59:02.488] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:21:0)
[08:59:02.533] Build status: STARTED
[08:59:02.533] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:22:0) after 6m41s
[09:05:43.549] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:22:0)
[09:05:43.566] Build status: STARTED
[09:05:43.566] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:23:0) after 2m16s
[09:07:59.608] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:23:0)
[09:07:59.626] Build status: STARTED
[09:07:59.626] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:24:0) after 6m28s
[09:14:27.642] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:24:0)
[09:14:27.687] Build status: STARTED
[09:14:27.687] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:25:0) after 9m25s
[09:23:52.696] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:25:0)
[09:23:52.713] Build status: STARTED
[09:23:52.713] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:26:0) after 5m17s
[09:29:09.833] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:26:0)
[09:29:09.850] Build status: STARTED
[09:29:09.850] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:27:0) after 4m53s
[09:34:02.985] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:27:0)
[09:34:03.008] Build status: STARTED
[09:34:03.008] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:28:0) after 5m43s
[09:39:46.133] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:28:0)
[09:39:46.159] Build status: STARTED
[09:39:46.159] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:29:0) after 4m46s
[09:44:32.171] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:29:0)
[09:44:32.196] Build status: STARTED
[09:44:32.196] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:30:0) after 1m30s
[09:46:02.313] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:30:0)
[09:46:02.391] Build status: STARTED
[09:46:02.392] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:31:0) after 2m23s
[09:48:25.549] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:31:0)
[09:48:25.576] Build status: STARTED
[09:48:25.576] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:32:0) after 2m43s
[09:51:08.804] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:32:0)
[09:51:08.831] Build status: STARTED
[09:51:08.831] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:33:0) after 9m54s
[10:01:02.974] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:33:0)
[10:01:03.018] Build status: STARTED
[10:01:03.018] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:34:0) after 6m43s
[10:07:46.042] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:34:0)
[10:07:46.056] Build status: STARTED
[10:07:46.056] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:35:0) after 1m39s
[10:09:25.298] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:35:0)
[10:09:25.320] Build status: STARTED
[10:09:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:36:0) after 9m31s
[10:18:56.343] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:36:0)
[10:18:56.404] Build status: STARTED
[10:18:56.404] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:37:0) after 9m36s
[10:28:32.524] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:37:0)
[10:28:32.546] Build status: STARTED
[10:28:32.546] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:38:0) after 2m24s
[10:30:56.580] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:38:0)
[10:30:56.599] Build status: STARTED
[10:30:56.600] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:39:0) after 4m58s
[10:35:54.615] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:39:0)
[10:35:54.972] Build status: STARTED
[10:35:54.972] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:40:0) after 3m5s
[10:39:00.000] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:40:0)
[10:39:00.014] Build status: STARTED
[10:39:00.014] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:41:0) after 5m55s
[10:44:55.052] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:41:0)
[10:44:55.070] Build status: STARTED
[10:44:55.070] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:42:0) after 5m44s
[10:50:39.533] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:42:0)
[10:50:39.549] Build status: STARTED
[10:50:39.549] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:43:0) after 4m0s
[10:54:39.747] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:43:0)
[10:54:39.802] Build status: STARTED
[10:54:39.802] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:44:0) after 4m34s
[10:59:13.854] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:44:0)
[10:59:13.889] Build status: STARTED
[10:59:13.889] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:45:0) after 3m12s
[11:02:26.370] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:45:0)
[11:02:26.394] Build status: STARTED
[11:02:26.394] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:46:0) after 5m5s
[11:07:31.564] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:46:0)
[11:07:31.579] Build status: STARTED
[11:07:31.579] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:47:0) after 6m41s
[11:14:12.774] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:47:0)
[11:14:12.793] Build status: STARTED
[11:14:12.793] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:48:0) after 8m48s
[11:23:00.816] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:48:0)
[11:23:00.849] Build status: STARTED
[11:23:00.849] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:49:0) after 5m50s
[11:28:50.992] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:49:0)
[11:28:51.018] Build status: STARTED
[11:28:51.018] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:50:0) after 9m32s
[11:38:23.040] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:50:0)
[11:38:23.063] Build status: STARTED
[11:38:23.063] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:51:0) after 2m23s
[11:40:46.131] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:51:0)
[11:40:46.145] Build status: STARTED
[11:40:46.145] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:52:0) after 8m47s
[11:49:33.312] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:52:0)
[11:49:33.332] Build status: STARTED
[11:49:33.332] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:53:0) after 8m16s
[11:57:49.358] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:53:0)
[11:57:49.384] Build status: STARTED
[11:57:49.384] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:54:0) after 4m19s
[12:02:08.420] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:54:0)
[12:02:08.434] Build status: STARTED
[12:02:08.434] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:55:0) after 8m22s
[12:10:30.539] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:55:0)
[12:10:30.556] Build status: STARTED
[12:10:30.556] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:56:0) after 5m27s
[12:15:57.639] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:56:0)
[12:15:57.692] Build status: STARTED
[12:15:57.692] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8879347189151685456:57:0) after 7m57s
[12:21:38.122] Received PubSub notification, asking Buildbucket for the build status
[12:21:38.158] Build:
{
"id": "8713917127321400193",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 58298,
"createdBy": "project:chromium",
"createTime": "2025-05-25T07:27:42.589806580Z",
"startTime": "2025-05-25T07:27:49.766886371Z",
"endTime": "2025-05-25T12:21:37.858615042Z",
"updateTime": "2025-05-25T12:21:37.858615042Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d9044a030a6ccfe9b7edabf5f484af298f9779ea",
"ref": "refs/heads/main"
}
}
}
[12:21:38.158] Invocation finished in 4h53m56.698670126s with status SUCCEEDED