[00:29:46.975] New invocation is queued and will start shortly
[00:29:48.043] Starting the invocation (attempt 1)
[00:29:48.069] Popped buildset tag "buildset:commit/gitiles/pdfium.googlesource.com/pdfium/+/ed4dccdfb903b94a80f890e3678973ebab339473"
[00:29:48.069] Popped gitiles commit info from properties and tags
[00:29:48.069] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:29:48.069] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:29:48.069] Buildbucket request:
{
"requestId": "8907096153379422800",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_asan"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907096153379422800",
"job": "pdfium/win_asan",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "5cbc3cc6e8ba0a8b243efefba8953b07db56cae4"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@5cbc3cc6e8ba0a8b243efefba8953b07db56cae4",
"title": "5cbc3cc6e8ba0a8b243efefba8953b07db56cae4",
"url": "https://pdfium.googlesource.com/pdfium/+/5cbc3cc6e8ba0a8b243efefba8953b07db56cae4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "5e365959e6bbc2c80954abebd0cd05b09f01224c"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@5e365959e6bbc2c80954abebd0cd05b09f01224c",
"title": "5e365959e6bbc2c80954abebd0cd05b09f01224c",
"url": "https://pdfium.googlesource.com/pdfium/+/5e365959e6bbc2c80954abebd0cd05b09f01224c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "a27b4774d5ec9d179a9df6b03db7889768f14ad3"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@a27b4774d5ec9d179a9df6b03db7889768f14ad3",
"title": "a27b4774d5ec9d179a9df6b03db7889768f14ad3",
"url": "https://pdfium.googlesource.com/pdfium/+/a27b4774d5ec9d179a9df6b03db7889768f14ad3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "32514cef98b131eedce1e580725e63f9b52bd6d8"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@32514cef98b131eedce1e580725e63f9b52bd6d8",
"title": "32514cef98b131eedce1e580725e63f9b52bd6d8",
"url": "https://pdfium.googlesource.com/pdfium/+/32514cef98b131eedce1e580725e63f9b52bd6d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pdfium.googlesource.com/pdfium",
"revision": "ed4dccdfb903b94a80f890e3678973ebab339473"
},
"id": "https://pdfium.googlesource.com/pdfium/+/refs/heads/main@ed4dccdfb903b94a80f890e3678973ebab339473",
"title": "ed4dccdfb903b94a80f890e3678973ebab339473",
"url": "https://pdfium.googlesource.com/pdfium/+/ed4dccdfb903b94a80f890e3678973ebab339473"
}
]
}
},
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "ed4dccdfb903b94a80f890e3678973ebab339473",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907096153379422800"
},
{
"key": "scheduler_job_id",
"value": "pdfium/win_asan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:29:49.574] Scheduled build:
{
"id": "8741666091326321441",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_asan"
},
"number": 7596,
"createdBy": "project:pdfium",
"createTime": "2024-07-23T00:29:48.310256564Z",
"updateTime": "2024-07-23T00:29:48.310256564Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "ed4dccdfb903b94a80f890e3678973ebab339473",
"ref": "refs/heads/main"
}
}
}
[00:29:49.574] Task URL: https://cr-buildbucket.appspot.com/build/8741666091326321441
[00:29:49.574] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:2:0) after 1m36s
[00:29:50.549] Received PubSub notification, asking Buildbucket for the build status
[00:29:50.569] Build status: SCHEDULED
[00:31:25.597] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:2:0)
[00:31:25.617] Build status: SCHEDULED
[00:31:25.617] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:4:0) after 3m15s
[00:34:40.713] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:4:0)
[00:34:40.746] Build status: SCHEDULED
[00:34:40.746] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:5:0) after 7m9s
[00:41:49.760] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:5:0)
[00:41:49.780] Build status: SCHEDULED
[00:41:49.780] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:6:0) after 4m24s
[00:46:13.770] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:6:0)
[00:46:13.797] Build status: SCHEDULED
[00:46:13.797] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:7:0) after 7m0s
[00:53:13.813] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:7:0)
[00:53:13.839] Build status: SCHEDULED
[00:53:13.839] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:8:0) after 9m1s
[01:02:14.875] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:8:0)
[01:02:14.893] Build status: SCHEDULED
[01:02:14.893] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:9:0) after 6m5s
[01:08:19.949] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:9:0)
[01:08:19.969] Build status: SCHEDULED
[01:08:19.969] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:10:0) after 6m40s
[01:13:01.870] Received PubSub notification, asking Buildbucket for the build status
[01:13:01.893] Build status: STARTED
[01:15:00.000] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:10:0)
[01:15:00.023] Build status: STARTED
[01:15:00.023] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:12:0) after 2m10s
[01:17:10.052] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:12:0)
[01:17:10.076] Build status: STARTED
[01:17:10.077] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:13:0) after 9m32s
[01:26:42.159] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:13:0)
[01:26:42.181] Build status: STARTED
[01:26:42.181] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:14:0) after 1m16s
[01:27:58.208] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:14:0)
[01:27:58.228] Build status: STARTED
[01:27:58.228] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:15:0) after 3m54s
[01:31:52.245] Handling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:15:0)
[01:31:52.265] Build status: STARTED
[01:31:52.265] Scheduling timer "check-buildbucket-build-status" (pdfium/win_asan:8907096153379422800:16:0) after 3m24s
[01:34:14.900] Received PubSub notification, asking Buildbucket for the build status
[01:34:14.926] Build:
{
"id": "8741666091326321441",
"builder": {
"project": "pdfium",
"bucket": "ci",
"builder": "win_asan"
},
"number": 7596,
"createdBy": "project:pdfium",
"createTime": "2024-07-23T00:29:48.310256564Z",
"startTime": "2024-07-23T01:13:01.601815910Z",
"endTime": "2024-07-23T01:34:14.633487086Z",
"updateTime": "2024-07-23T01:34:14.633487086Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "pdfium.googlesource.com",
"project": "pdfium",
"id": "ed4dccdfb903b94a80f890e3678973ebab339473",
"ref": "refs/heads/main"
}
}
}
[01:34:14.926] Invocation finished in 1h4m27.957644975s with status SUCCEEDED