[06:01:14.411] New invocation is queued and will start shortly
[06:01:15.477] Starting the invocation (attempt 1)
[06:01:15.505] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f6c3fc2c75be9e47e5f9252a93c3da481ac706bf"
[06:01:15.505] Popped gitiles commit info from properties and tags
[06:01:15.505] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:01:15.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:01:15.507] Buildbucket request:
{
"requestId": "8922929769011105776",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f6c3fc2c75be9e47e5f9252a93c3da481ac706bf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922929769011105776"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Linux ASan Debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:01:16.273] Scheduled build:
{
"id": "8757499707095601649",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 151324,
"createdBy": "project:chromium",
"createTime": "2024-01-30T06:01:15.615208051Z",
"updateTime": "2024-01-30T06:01:15.615208051Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f6c3fc2c75be9e47e5f9252a93c3da481ac706bf",
"ref": "refs/heads/main"
}
}
}
[06:01:16.273] Task URL: https://cr-buildbucket.appspot.com/build/8757499707095601649
[06:01:16.273] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:2:0) after 5m31s
[06:01:17.255] Received PubSub notification, asking Buildbucket for the build status
[06:01:17.273] Build status: SCHEDULED
[06:06:47.280] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:2:0)
[06:06:47.312] Build status: SCHEDULED
[06:06:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:4:0) after 8m1s
[06:14:48.343] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:4:0)
[06:14:48.365] Build status: SCHEDULED
[06:14:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:5:0) after 8m19s
[06:23:07.549] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:5:0)
[06:23:07.577] Build status: SCHEDULED
[06:23:07.577] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:6:0) after 5m39s
[06:28:46.610] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:6:0)
[06:28:46.636] Build status: SCHEDULED
[06:28:46.636] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:7:0) after 9m9s
[06:37:55.808] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:7:0)
[06:37:55.822] Build status: SCHEDULED
[06:37:55.822] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:8:0) after 5m14s
[06:43:09.930] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:8:0)
[06:43:09.949] Build status: SCHEDULED
[06:43:09.949] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:9:0) after 9m58s
[06:49:10.827] Received PubSub notification, asking Buildbucket for the build status
[06:49:10.959] Build status: STARTED
[06:53:07.963] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:9:0)
[06:53:07.979] Build status: STARTED
[06:53:07.979] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:11:0) after 2m37s
[06:55:45.075] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:11:0)
[06:55:45.099] Build status: STARTED
[06:55:45.099] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:12:0) after 3m16s
[06:59:01.121] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:12:0)
[06:59:01.138] Build status: STARTED
[06:59:01.138] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:13:0) after 9m7s
[07:08:08.273] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:13:0)
[07:08:08.293] Build status: STARTED
[07:08:08.293] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:14:0) after 6m4s
[07:14:12.308] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:14:0)
[07:14:12.340] Build status: STARTED
[07:14:12.340] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:15:0) after 8m49s
[07:23:01.590] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:15:0)
[07:23:01.611] Build status: STARTED
[07:23:01.611] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:16:0) after 4m35s
[07:27:36.887] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:16:0)
[07:27:36.909] Build status: STARTED
[07:27:36.909] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:17:0) after 4m43s
[07:32:19.932] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:17:0)
[07:32:20.044] Build status: STARTED
[07:32:20.044] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:18:0) after 6m17s
[07:38:37.059] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:18:0)
[07:38:37.080] Build status: STARTED
[07:38:37.080] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:19:0) after 8m26s
[07:47:03.115] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:19:0)
[07:47:03.134] Build status: STARTED
[07:47:03.134] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:20:0) after 9m51s
[07:56:54.160] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:20:0)
[07:56:54.177] Build status: STARTED
[07:56:54.177] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8922929769011105776:21:0) after 4m15s
[07:57:50.449] Received PubSub notification, asking Buildbucket for the build status
[07:57:50.470] Build:
{
"id": "8757499707095601649",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 151324,
"createdBy": "project:chromium",
"createTime": "2024-01-30T06:01:15.615208051Z",
"startTime": "2024-01-30T06:49:10.168903Z",
"endTime": "2024-01-30T07:57:49.386799Z",
"updateTime": "2024-01-30T07:57:49.386799Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "f6c3fc2c75be9e47e5f9252a93c3da481ac706bf",
"ref": "refs/heads/main"
}
}
}
[07:57:50.470] Invocation finished in 1h56m36.064760399s with status SUCCEEDED