[11:52:56.355] New invocation is queued and will start shortly
[11:52:57.642] Starting the invocation (attempt 1)
[11:52:57.683] Ignoring gitiles_ref tag without the buildset tag
[11:52:57.683] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:52:57.683] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:52:57.684] Buildbucket request:
{
"requestId": "9017490874949177072",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-upload-perfetto"
},
"properties": {
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017490874949177072"
},
{
"key": "scheduler_job_id",
"value": "chromium/win-upload-perfetto"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[11:52:58.168] Scheduled build:
{
"id": "8852060812796833808",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-upload-perfetto"
},
"number": 2499,
"createdBy": "project:chromium",
"createTime": "2021-03-22T11:52:57.777359Z",
"updateTime": "2021-03-22T11:52:58.099976Z",
"status": "SCHEDULED",
"input": {
}
}
[11:52:58.168] Task URL: https://cr-buildbucket.appspot.com/build/8852060812796833808
[11:52:58.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:2:0) after 4m40s
[11:57:38.182] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:2:0)
[11:57:38.182] Timer tick, asking Buildbucket for the build status
[11:57:38.286] Build 8852060812796833808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:57:38.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:3:0) after 1m0s
[11:58:38.299] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:3:0)
[11:58:38.299] Timer tick, asking Buildbucket for the build status
[11:58:38.717] Build 8852060812796833808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:58:38.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:4:0) after 1m0s
[11:59:38.692] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:4:0)
[11:59:38.719] Build status: SCHEDULED
[11:59:38.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:5:0) after 9m21s
[12:08:59.804] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:5:0)
[12:08:59.804] Timer tick, asking Buildbucket for the build status
[12:08:59.883] Build 8852060812796833808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:08:59.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:6:0) after 1m0s
[12:09:59.925] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:6:0)
[12:09:59.960] Build status: SCHEDULED
[12:09:59.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:7:0) after 7m17s
[12:17:16.983] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:7:0)
[12:17:16.983] Timer tick, asking Buildbucket for the build status
[12:17:17.128] Build 8852060812796833808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:8:0) after 1m0s
[12:17:46.431] Received PubSub notification, asking Buildbucket for the build status
[12:17:46.454] Build status: STARTED
[12:18:17.147] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:8:0)
[12:18:17.188] Build status: STARTED
[12:18:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:10:0) after 7m48s
[12:26:06.525] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:10:0)
[12:26:06.587] Build status: STARTED
[12:26:06.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:11:0) after 4m33s
[12:30:39.610] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:11:0)
[12:30:39.610] Timer tick, asking Buildbucket for the build status
[12:30:39.896] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:12:0) after 1m0s
[12:31:39.915] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:12:0)
[12:31:39.915] Timer tick, asking Buildbucket for the build status
[12:31:40.023] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:40.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:13:0) after 1m0s
[12:32:40.038] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:13:0)
[12:32:40.038] Timer tick, asking Buildbucket for the build status
[12:32:40.112] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:40.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:14:0) after 1m0s
[12:33:40.128] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:14:0)
[12:33:40.128] Timer tick, asking Buildbucket for the build status
[12:33:40.301] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:40.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:15:0) after 1m0s
[12:34:40.377] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:15:0)
[12:34:40.406] Build status: STARTED
[12:34:40.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:16:0) after 9m25s
[12:44:05.422] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:16:0)
[12:44:05.422] Timer tick, asking Buildbucket for the build status
[12:44:05.538] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:05.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:17:0) after 1m0s
[12:45:05.559] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:17:0)
[12:45:05.604] Build status: STARTED
[12:45:05.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:18:0) after 7m13s
[12:52:18.636] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:18:0)
[12:52:18.636] Timer tick, asking Buildbucket for the build status
[12:52:18.716] Build 8852060812796833808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:18.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:19:0) after 1m0s
[12:53:18.783] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:19:0)
[12:53:18.807] Build status: STARTED
[12:53:18.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:20:0) after 3m15s
[12:56:33.827] Handling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:20:0)
[12:56:33.851] Build status: STARTED
[12:56:33.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-upload-perfetto:9017490874949177072:21:0) after 7m59s
[12:58:51.560] Received PubSub notification, asking Buildbucket for the build status
[12:58:51.583] Build:
{
"id": "8852060812796833808",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-upload-perfetto"
},
"number": 2499,
"createdBy": "project:chromium",
"createTime": "2021-03-22T11:52:57.777359Z",
"startTime": "2021-03-22T12:17:45.846624Z",
"endTime": "2021-03-22T12:58:51.096814320Z",
"updateTime": "2021-03-22T12:58:51.097135616Z",
"status": "SUCCESS",
"input": {
}
}
[12:58:51.583] Invocation finished in 1h5m55.242568894s with status SUCCEEDED