[17:23:59.286] New invocation is queued and will start shortly
[17:24:00.357] Starting the invocation (attempt 1)
[17:24:00.382] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40c696ebb4ebb886360967e9074f929641e8c3db"
[17:24:00.382] Popped gitiles commit info from properties and tags
[17:24:00.382] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:24:00.382] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:24:00.382] Buildbucket request:
{
"requestId": "8898063245444135664",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "40c696ebb4ebb886360967e9074f929641e8c3db",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898063245444135664"
},
{
"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"
}
}
[17:24:01.123] Scheduled build:
{
"id": "8732633183549709985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 55399,
"createdBy": "project:chromium",
"createTime": "2024-10-30T17:24:00.459608183Z",
"updateTime": "2024-10-30T17:24:00.459608183Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "40c696ebb4ebb886360967e9074f929641e8c3db",
"ref": "refs/heads/main"
}
}
}
[17:24:01.123] Task URL: https://cr-buildbucket.appspot.com/build/8732633183549709985
[17:24:01.123] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:2:0) after 6m47s
[17:24:02.054] Received PubSub notification, asking Buildbucket for the build status
[17:24:02.301] Build status: SCHEDULED
[17:25:30.376] Received PubSub notification, asking Buildbucket for the build status
[17:25:30.412] Build status: STARTED
[17:30:48.139] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:2:0)
[17:30:48.213] Build status: STARTED
[17:30:48.213] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:5:0) after 3m50s
[17:34:38.236] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:5:0)
[17:34:38.256] Build status: STARTED
[17:34:38.256] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:6:0) after 6m30s
[17:41:08.265] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:6:0)
[17:41:08.291] Build status: STARTED
[17:41:08.291] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:7:0) after 6m59s
[17:48:07.355] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:7:0)
[17:48:07.383] Build status: STARTED
[17:48:07.383] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:8:0) after 4m30s
[17:52:37.398] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:8:0)
[17:52:37.414] Build status: STARTED
[17:52:37.414] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:9:0) after 7m12s
[17:59:49.465] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:9:0)
[17:59:49.486] Build status: STARTED
[17:59:49.486] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:10:0) after 9m53s
[18:09:42.603] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:10:0)
[18:09:42.638] Build status: STARTED
[18:09:42.638] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:11:0) after 7m0s
[18:16:42.682] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:11:0)
[18:16:42.701] Build status: STARTED
[18:16:42.701] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:12:0) after 5m46s
[18:22:28.718] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:12:0)
[18:22:28.734] Build status: STARTED
[18:22:28.734] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:13:0) after 5m37s
[18:28:05.778] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:13:0)
[18:28:05.798] Build status: STARTED
[18:28:05.798] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:14:0) after 7m1s
[18:35:06.856] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:14:0)
[18:35:06.887] Build status: STARTED
[18:35:06.887] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:15:0) after 6m3s
[18:41:09.987] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:15:0)
[18:41:10.049] Build status: STARTED
[18:41:10.049] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:16:0) after 3m30s
[18:44:40.157] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:16:0)
[18:44:40.174] Build status: STARTED
[18:44:40.174] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:17:0) after 9m58s
[18:54:38.192] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:17:0)
[18:54:38.207] Build status: STARTED
[18:54:38.207] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:18:0) after 8m44s
[19:03:22.322] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:18:0)
[19:03:22.360] Build status: STARTED
[19:03:22.360] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:19:0) after 2m46s
[19:06:08.401] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:19:0)
[19:06:08.415] Build status: STARTED
[19:06:08.415] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:20:0) after 8m28s
[19:14:36.504] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:20:0)
[19:14:36.562] Build status: STARTED
[19:14:36.562] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:21:0) after 5m58s
[19:20:34.650] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:21:0)
[19:20:34.688] Build status: STARTED
[19:20:34.688] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:22:0) after 5m49s
[19:26:23.726] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:22:0)
[19:26:23.746] Build status: STARTED
[19:26:23.746] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:23:0) after 5m55s
[19:32:18.844] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:23:0)
[19:32:18.864] Build status: STARTED
[19:32:18.864] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:24:0) after 3m10s
[19:35:28.880] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:24:0)
[19:35:28.903] Build status: STARTED
[19:35:28.903] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:25:0) after 7m27s
[19:42:55.923] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:25:0)
[19:42:55.948] Build status: STARTED
[19:42:55.948] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:26:0) after 7m9s
[19:50:04.969] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:26:0)
[19:50:04.999] Build status: STARTED
[19:50:04.999] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:27:0) after 9m49s
[19:59:54.018] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:27:0)
[19:59:54.039] Build status: STARTED
[19:59:54.039] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:28:0) after 6m44s
[20:06:38.026] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:28:0)
[20:06:38.055] Build status: STARTED
[20:06:38.055] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:29:0) after 1m29s
[20:08:07.122] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:29:0)
[20:08:07.175] Build status: STARTED
[20:08:07.175] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:30:0) after 5m54s
[20:14:01.229] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:30:0)
[20:14:01.274] Build status: STARTED
[20:14:01.274] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:31:0) after 7m31s
[20:21:32.292] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:31:0)
[20:21:32.329] Build status: STARTED
[20:21:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:32:0) after 4m3s
[20:25:35.433] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:32:0)
[20:25:35.450] Build status: STARTED
[20:25:35.450] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:33:0) after 2m56s
[20:28:31.486] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:33:0)
[20:28:31.506] Build status: STARTED
[20:28:31.506] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:34:0) after 6m42s
[20:35:13.575] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:34:0)
[20:35:13.594] Build status: STARTED
[20:35:13.594] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:35:0) after 8m12s
[20:43:25.656] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:35:0)
[20:43:25.674] Build status: STARTED
[20:43:25.674] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:36:0) after 5m56s
[20:49:21.742] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:36:0)
[20:49:21.769] Build status: STARTED
[20:49:21.769] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:37:0) after 7m14s
[20:56:35.837] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:37:0)
[20:56:35.887] Build status: STARTED
[20:56:35.887] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:38:0) after 7m48s
[21:04:23.907] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:38:0)
[21:04:23.929] Build status: STARTED
[21:04:23.929] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:39:0) after 7m7s
[21:11:30.946] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:39:0)
[21:11:30.973] Build status: STARTED
[21:11:30.973] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:40:0) after 6m9s
[21:17:39.994] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:40:0)
[21:17:40.015] Build status: STARTED
[21:17:40.015] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:41:0) after 5m12s
[21:22:52.037] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:41:0)
[21:22:52.057] Build status: STARTED
[21:22:52.057] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:42:0) after 9m41s
[21:32:33.077] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:42:0)
[21:32:33.105] Build status: STARTED
[21:32:33.105] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:43:0) after 8m59s
[21:41:32.239] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:43:0)
[21:41:32.265] Build status: STARTED
[21:41:32.265] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:44:0) after 5m9s
[21:46:41.280] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:44:0)
[21:46:41.298] Build status: STARTED
[21:46:41.299] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:45:0) after 4m13s
[21:50:54.320] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:45:0)
[21:50:54.339] Build status: STARTED
[21:50:54.339] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:46:0) after 2m56s
[21:53:50.405] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:46:0)
[21:53:50.499] Build status: STARTED
[21:53:50.500] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:47:0) after 9m19s
[22:03:09.526] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:47:0)
[22:03:09.544] Build status: STARTED
[22:03:09.544] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:48:0) after 2m45s
[22:05:54.563] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:48:0)
[22:05:54.580] Build status: STARTED
[22:05:54.580] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:49:0) after 3m26s
[22:09:20.700] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:49:0)
[22:09:20.770] Build status: STARTED
[22:09:20.770] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:50:0) after 8m24s
[22:17:44.835] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:50:0)
[22:17:44.870] Build status: STARTED
[22:17:44.870] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:51:0) after 6m53s
[22:24:37.950] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:51:0)
[22:24:37.973] Build status: STARTED
[22:24:37.973] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:52:0) after 6m34s
[22:31:12.096] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:52:0)
[22:31:12.116] Build status: STARTED
[22:31:12.116] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:53:0) after 6m4s
[22:37:16.153] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:53:0)
[22:37:16.174] Build status: STARTED
[22:37:16.174] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:54:0) after 1m30s
[22:38:46.271] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:54:0)
[22:38:46.293] Build status: STARTED
[22:38:46.293] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:55:0) after 6m9s
[22:44:55.308] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:55:0)
[22:44:55.325] Build status: STARTED
[22:44:55.325] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:56:0) after 7m45s
[22:52:40.393] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:56:0)
[22:52:40.412] Build status: STARTED
[22:52:40.412] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:57:0) after 4m41s
[22:57:21.428] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:57:0)
[22:57:21.446] Build status: STARTED
[22:57:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:58:0) after 8m32s
[23:05:53.514] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:58:0)
[23:05:53.539] Build status: STARTED
[23:05:53.539] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:59:0) after 1m48s
[23:07:41.617] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:59:0)
[23:07:41.635] Build status: STARTED
[23:07:41.636] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8898063245444135664:60:0) after 8m50s
[23:13:17.237] Received PubSub notification, asking Buildbucket for the build status
[23:13:17.318] Build:
{
"id": "8732633183549709985",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 55399,
"createdBy": "project:chromium",
"createTime": "2024-10-30T17:24:00.459608183Z",
"startTime": "2024-10-30T17:25:30.135585238Z",
"endTime": "2024-10-30T23:13:15.773693037Z",
"updateTime": "2024-10-30T23:13:15.773693037Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "40c696ebb4ebb886360967e9074f929641e8c3db",
"ref": "refs/heads/main"
}
}
}
[23:13:17.319] Invocation finished in 5h49m18.049279845s with status SUCCEEDED