[21:06:10.877] New invocation is queued and will start shortly
[21:06:11.989] Starting the invocation (attempt 1)
[21:06:12.021] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6385dfcd1c8dc41416eef6d6a072b2b061b98b84"
[21:06:12.021] Popped gitiles commit info from properties and tags
[21:06:12.021] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:06:12.021] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:06:12.021] Buildbucket request:
{
"requestId": "8948511776533221344",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6385dfcd1c8dc41416eef6d6a072b2b061b98b84",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8948511776533221344"
},
{
"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"
}
}
[21:06:12.504] Scheduled build:
{
"id": "8783081714555419553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 47479,
"createdBy": "project:chromium",
"createTime": "2023-04-22T21:06:12.139320104Z",
"updateTime": "2023-04-22T21:06:12.139320104Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6385dfcd1c8dc41416eef6d6a072b2b061b98b84",
"ref": "refs/heads/main"
}
}
}
[21:06:12.504] Task URL: https://cr-buildbucket.appspot.com/build/8783081714555419553
[21:06:12.504] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:2:0) after 9m20s
[21:15:32.597] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:2:0)
[21:15:32.615] Build status: SCHEDULED
[21:15:32.615] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:3:0) after 8m42s
[21:16:58.473] Received PubSub notification, asking Buildbucket for the build status
[21:16:58.499] Build status: STARTED
[21:24:14.612] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:3:0)
[21:24:14.642] Build status: STARTED
[21:24:14.642] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:5:0) after 2m55s
[21:27:09.756] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:5:0)
[21:27:09.779] Build status: STARTED
[21:27:09.779] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:6:0) after 6m36s
[21:33:45.798] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:6:0)
[21:33:45.826] Build status: STARTED
[21:33:45.826] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:7:0) after 7m27s
[21:41:12.843] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:7:0)
[21:41:12.862] Build status: STARTED
[21:41:12.862] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:8:0) after 5m23s
[21:46:35.888] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:8:0)
[21:46:35.920] Build status: STARTED
[21:46:35.920] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:9:0) after 1m27s
[21:48:03.021] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:9:0)
[21:48:03.038] Build status: STARTED
[21:48:03.039] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:10:0) after 3m57s
[21:52:00.271] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:10:0)
[21:52:00.290] Build status: STARTED
[21:52:00.290] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:11:0) after 2m49s
[21:54:49.315] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:11:0)
[21:54:49.334] Build status: STARTED
[21:54:49.335] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:12:0) after 1m26s
[21:56:15.351] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:12:0)
[21:56:15.375] Build status: STARTED
[21:56:15.375] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:13:0) after 9m20s
[22:05:35.391] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:13:0)
[22:05:35.408] Build status: STARTED
[22:05:35.408] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:14:0) after 9m26s
[22:15:01.880] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:14:0)
[22:15:01.899] Build status: STARTED
[22:15:01.900] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:15:0) after 2m34s
[22:17:35.909] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:15:0)
[22:17:35.928] Build status: STARTED
[22:17:35.928] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:16:0) after 9m50s
[22:27:25.947] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:16:0)
[22:27:25.964] Build status: STARTED
[22:27:25.964] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:17:0) after 2m4s
[22:29:29.997] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:17:0)
[22:29:30.017] Build status: STARTED
[22:29:30.017] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:18:0) after 9m41s
[22:39:11.466] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:18:0)
[22:39:11.490] Build status: STARTED
[22:39:11.490] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:19:0) after 3m32s
[22:42:43.514] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:19:0)
[22:42:43.538] Build status: STARTED
[22:42:43.538] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:20:0) after 6m42s
[22:49:25.561] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:20:0)
[22:49:25.580] Build status: STARTED
[22:49:25.580] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:21:0) after 4m55s
[22:54:20.842] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:21:0)
[22:54:20.864] Build status: STARTED
[22:54:20.865] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:22:0) after 4m32s
[22:58:52.889] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:22:0)
[22:58:52.910] Build status: STARTED
[22:58:52.910] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:23:0) after 6m20s
[23:05:12.931] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:23:0)
[23:05:12.947] Build status: STARTED
[23:05:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:24:0) after 8m29s
[23:13:41.932] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:24:0)
[23:13:41.981] Build status: STARTED
[23:13:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:25:0) after 4m1s
[23:17:43.000] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:25:0)
[23:17:43.021] Build status: STARTED
[23:17:43.021] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:26:0) after 2m54s
[23:20:37.132] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:26:0)
[23:20:37.151] Build status: STARTED
[23:20:37.151] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:27:0) after 6m14s
[23:26:51.169] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:27:0)
[23:26:51.193] Build status: STARTED
[23:26:51.193] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:28:0) after 8m40s
[23:35:31.259] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:28:0)
[23:35:31.280] Build status: STARTED
[23:35:31.280] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:29:0) after 7m52s
[23:43:23.601] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:29:0)
[23:43:23.680] Build status: STARTED
[23:43:23.680] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:30:0) after 5m16s
[23:48:39.697] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:30:0)
[23:48:39.718] Build status: STARTED
[23:48:39.718] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:31:0) after 7m9s
[23:55:48.745] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:31:0)
[23:55:48.839] Build status: STARTED
[23:55:48.839] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:32:0) after 1m10s
[23:56:59.514] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:32:0)
[23:56:59.536] Build status: STARTED
[23:56:59.536] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:33:0) after 4m44s
[00:01:43.541] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:33:0)
[00:01:43.559] Build status: STARTED
[00:01:43.559] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:34:0) after 3m34s
[00:05:17.570] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:34:0)
[00:05:17.602] Build status: STARTED
[00:05:17.602] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:35:0) after 9m12s
[00:14:29.735] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:35:0)
[00:14:29.756] Build status: STARTED
[00:14:29.756] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:36:0) after 3m23s
[00:17:52.847] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:36:0)
[00:17:52.867] Build status: STARTED
[00:17:52.867] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:37:0) after 8m2s
[00:25:54.943] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:37:0)
[00:25:55.092] Build status: STARTED
[00:25:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:38:0) after 7m23s
[00:33:18.468] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:38:0)
[00:33:18.489] Build status: STARTED
[00:33:18.489] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Windows ASan:8948511776533221344:39:0) after 9m42s
[00:34:27.856] Received PubSub notification, asking Buildbucket for the build status
[00:34:27.880] Build:
{
"id": "8783081714555419553",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Windows ASan"
},
"number": 47479,
"createdBy": "project:chromium",
"createTime": "2023-04-22T21:06:12.139320104Z",
"startTime": "2023-04-22T21:16:57.866556Z",
"endTime": "2023-04-23T00:34:27.578065680Z",
"updateTime": "2023-04-23T00:34:27.578065680Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6385dfcd1c8dc41416eef6d6a072b2b061b98b84",
"ref": "refs/heads/main"
}
}
}
[00:34:27.880] Invocation finished in 3h28m17.011004788s with status SUCCEEDED