[41.878758] Initializing watchdogs
[41.879355]   /dev/watchdog0
[41.907308] [001/162] (960s left) i915_module_load (load)
[42.327814] Starting subtest: load
[46.301358] Subtest load: SUCCESS (3.975s)
[46.376989] [002/162] (956s left) core_auth (basic-auth)
[48.097319] Starting subtest: basic-auth
[48.104166] Subtest basic-auth: SUCCESS (0.004s)
[48.276787] [003/162] (954s left) debugfs_test (read_all_entries)
[48.689821] Starting subtest: read_all_entries
[50.020302] Subtest read_all_entries: SUCCESS (1.327s)
[50.263984] [004/162] (952s left) debugfs_test (basic-hwmon)
[50.667725] Starting subtest: basic-hwmon
[50.681302] Subtest basic-hwmon: SKIP (0.000s)
[50.907482] [005/162] (951s left) fbdev (eof)
[51.296815] Starting subtest: eof
[51.304346] Subtest eof: SUCCESS (0.002s)
[51.456296] [006/162] (951s left) fbdev (info)
[51.836127] Starting subtest: info
[51.842850] Subtest info: SUCCESS (0.000s)
[51.994656] [007/162] (950s left) fbdev (nullptr)
[52.371259] Starting subtest: nullptr
[52.378175] Subtest nullptr: SUCCESS (0.000s)
[52.512954] [008/162] (950s left) fbdev (read)
[52.899422] Starting subtest: read
[57.677158] Subtest read: SUCCESS (4.769s)
[57.838184] [009/162] (945s left) fbdev (write)
[58.251762] Starting subtest: write
[61.488114] Subtest write: SUCCESS (3.232s)
[61.663237] [010/162] (941s left) gem_basic (bad-close)
[62.044144] Starting subtest: bad-close
[62.058434] Subtest bad-close: SUCCESS (0.000s)
[62.200348] [011/162] (940s left) gem_basic (create-close)
[62.588759] Starting subtest: create-close
[62.602696] Subtest create-close: SUCCESS (0.000s)
[62.776877] [012/162] (940s left) gem_basic (create-fd-close)
[63.157133] Starting subtest: create-fd-close
[63.170941] Subtest create-fd-close: SUCCESS (0.001s)
[63.336931] [013/162] (939s left) gem_busy (busy@all-engines)
[63.791205] Starting subtest: busy
[63.798442] Starting dynamic subtest: all-engines
[64.017210] Dynamic subtest all-engines: SUCCESS (0.225s)
[64.024401] Subtest busy: SUCCESS (0.227s)
[65.368573] [014/162] (938s left) gem_close_race (basic-process)
[65.817247] Starting subtest: basic-process
[65.919931] Subtest basic-process: SUCCESS (0.102s)
[66.198240] [015/162] (937s left) gem_close_race (basic-threads)
[66.667237] Starting subtest: basic-threads
[68.151738] Subtest basic-threads: SUCCESS (1.492s)
[68.437415] [016/162] (935s left) gem_ctx_create (basic)
[68.881076] Starting subtest: basic
[68.887999] Subtest basic: SUCCESS (0.000s)
[69.170727] [017/162] (934s left) gem_ctx_create (basic-files)
[69.620185] Starting subtest: basic-files
[71.689642] Subtest basic-files: SUCCESS (2.076s)
[73.324705] [018/162] (930s left) gem_ctx_exec (basic)
[73.718812] Starting subtest: basic
[73.733651] Subtest basic: SUCCESS (0.015s)
[73.951693] [019/162] (929s left) gem_exec_basic (basic)
[74.368345] Starting subtest: basic
[74.375333] Starting dynamic subtest: rcs0-smem
[74.382513] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[74.418278] Starting dynamic subtest: bcs0-smem
[74.425400] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[74.460124] Starting dynamic subtest: vcs0-smem
[74.467259] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[74.500459] Starting dynamic subtest: vcs1-smem
[74.507351] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[74.543292] Starting dynamic subtest: vecs0-smem
[74.550342] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[74.584672] Starting dynamic subtest: ccs0-smem
[74.594128] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[74.602174] Subtest basic: SUCCESS (0.025s)
[76.338250] [020/162] (927s left) gem_exec_create (basic)
[76.775989] Starting subtest: basic
[76.783529] Starting dynamic subtest: smem
[80.165187] Dynamic subtest smem: SUCCESS (3.379s)
[80.172212] Subtest basic: SUCCESS (3.380s)
[80.450961] [021/162] (923s left) gem_exec_fence (basic-busy)
[81.071148] Starting subtest: basic-busy
[81.080290] Starting dynamic subtest: rcs0
[81.137698] Dynamic subtest rcs0: SUCCESS (0.074s)
[81.177714] Starting dynamic subtest: bcs0
[81.204375] Dynamic subtest bcs0: SUCCESS (0.064s)
[81.241473] Starting dynamic subtest: vcs0
[81.258959] Dynamic subtest vcs0: SUCCESS (0.037s)
[81.295759] Starting dynamic subtest: vcs1
[81.310066] Dynamic subtest vcs1: SUCCESS (0.042s)
[81.348338] Starting dynamic subtest: vecs0
[81.361897] Dynamic subtest vecs0: SUCCESS (0.030s)
[81.399468] Starting dynamic subtest: ccs0
[81.412853] Dynamic subtest ccs0: SUCCESS (0.060s)
[81.419696] Subtest basic-busy: SUCCESS (0.311s)
[83.431884] [022/162] (920s left) gem_exec_fence (basic-wait)
[84.052097] Starting subtest: basic-wait
[84.059808] Starting dynamic subtest: rcs0
[84.133418] Dynamic subtest rcs0: SUCCESS (0.089s)
[84.173762] Starting dynamic subtest: bcs0
[84.196427] Dynamic subtest bcs0: SUCCESS (0.062s)
[84.233374] Starting dynamic subtest: vcs0
[84.240642] Dynamic subtest vcs0: SUCCESS (0.033s)
[84.276810] Starting dynamic subtest: vcs1
[84.284238] Dynamic subtest vcs1: SUCCESS (0.035s)
[84.320654] Starting dynamic subtest: vecs0
[84.328310] Dynamic subtest vecs0: SUCCESS (0.039s)
[84.364307] Starting dynamic subtest: ccs0
[84.371265] Dynamic subtest ccs0: SUCCESS (0.058s)
[84.378103] Subtest basic-wait: SUCCESS (0.322s)
[86.399204] [023/162] (917s left) gem_exec_fence (basic-await)
[87.010365] Starting subtest: basic-await
[87.018793] Starting dynamic subtest: rcs0
[87.256359] Dynamic subtest rcs0: SUCCESS (0.260s)
[87.293518] Starting dynamic subtest: bcs0
[87.489876] Dynamic subtest bcs0: SUCCESS (0.233s)
[87.524963] Starting dynamic subtest: vcs0
[87.717446] Dynamic subtest vcs0: SUCCESS (0.227s)
[87.752054] Starting dynamic subtest: vcs1
[87.938844] Dynamic subtest vcs1: SUCCESS (0.220s)
[87.974418] Starting dynamic subtest: vecs0
[88.173579] Dynamic subtest vecs0: SUCCESS (0.234s)
[88.197581] Starting dynamic subtest: ccs0
[88.392296] Dynamic subtest ccs0: SUCCESS (0.218s)
[88.399374] Subtest basic-await: SUCCESS (1.397s)
[90.433483] [024/162] (913s left) gem_exec_fence (nb-await)
[91.049125] Starting subtest: nb-await
[91.056610] Starting dynamic subtest: rcs0
[91.160233] Dynamic subtest rcs0: SUCCESS (0.118s)
[91.197196] Starting dynamic subtest: bcs0
[91.246625] Dynamic subtest bcs0: SUCCESS (0.086s)
[91.282610] Starting dynamic subtest: vcs0
[91.339553] Dynamic subtest vcs0: SUCCESS (0.092s)
[91.377085] Starting dynamic subtest: vcs1
[91.426880] Dynamic subtest vcs1: SUCCESS (0.087s)
[91.462584] Starting dynamic subtest: vecs0
[91.513696] Dynamic subtest vecs0: SUCCESS (0.086s)
[91.550357] Starting dynamic subtest: ccs0
[91.601188] Dynamic subtest ccs0: SUCCESS (0.087s)
[91.608377] Subtest nb-await: SUCCESS (0.561s)
[93.718544] [025/162] (910s left) gem_exec_gttfill (basic)
[94.163692] Starting subtest: basic
[105.320204] Subtest basic: SUCCESS (11.147s)
[105.592562] [026/162] (898s left) gem_exec_parallel (engines)
[106.169812] Starting subtest: engines
[106.177251] Starting dynamic subtest: basic
[111.134322] Dynamic subtest basic: SUCCESS (4.962s)
[111.175124] Starting dynamic subtest: contexts
[117.520305] Dynamic subtest contexts: SUCCESS (6.384s)
[117.560622] Starting dynamic subtest: fds
[124.202624] Dynamic subtest fds: SUCCESS (6.679s)
[124.248932] Starting dynamic subtest: userptr
[127.283867] Dynamic subtest userptr: SUCCESS (3.091s)
[127.290904] Subtest engines: SUCCESS (21.121s)
[127.641852] [027/162] (876s left) gem_exec_store (basic)
[128.081844] Starting subtest: basic
[129.174129] Subtest basic: SUCCESS (1.084s)
[129.464872] [028/162] (875s left) gem_flink_basic (bad-flink)
[129.850112] Starting subtest: bad-flink
[129.857737] Subtest bad-flink: SUCCESS (0.000s)
[130.015935] [029/162] (874s left) gem_flink_basic (bad-open)
[130.403191] Starting subtest: bad-open
[130.410208] Subtest bad-open: SUCCESS (0.000s)
[130.574499] [030/162] (874s left) gem_flink_basic (basic)
[130.957766] Starting subtest: basic
[130.964223] Subtest basic: SUCCESS (0.000s)
[131.160877] [031/162] (873s left) gem_flink_basic (double-flink)
[131.550081] Starting subtest: double-flink
[131.556942] Subtest double-flink: SUCCESS (0.000s)
[131.727964] [032/162] (873s left) gem_flink_basic (flink-lifetime)
[132.125820] Starting subtest: flink-lifetime
[132.133313] Subtest flink-lifetime: SUCCESS (0.008s)
[132.325947] [033/162] (872s left) gem_huc_copy (huc-copy)
[132.753276] Starting subtest: huc-copy
[132.768636] Subtest huc-copy: SUCCESS (0.014s)
[134.323386] [034/162] (870s left) gem_linear_blits (basic)
[135.266266] Starting subtest: basic
[135.295071] Subtest basic: SUCCESS (0.037s)
[135.539086] [035/162] (869s left) gem_mmap (basic)
[136.060518] Subtest basic: SKIP (0.000s)
[136.184674] [036/162] (869s left) gem_mmap_gtt (basic)
[136.583115] Subtest basic: SKIP (0.000s)
[136.713137] [037/162] (868s left) gem_render_linear_blits (basic)
[137.122179] Starting subtest: basic
[137.281891] Subtest basic: SUCCESS (0.163s)
[137.462580] [038/162] (867s left) gem_render_tiled_blits (basic)
[137.888439] Subtest basic: SKIP (0.000s)
[138.018817] [039/162] (867s left) gem_ringfill (basic-all)
[144.169344] Starting subtest: basic-all
[145.484898] Subtest basic-all: SUCCESS (1.321s)
[146.292826] [040/162] (859s left) gem_softpin (allocator-basic)
[146.713209] Starting subtest: allocator-basic
[147.290207] Subtest allocator-basic: SUCCESS (0.577s)
[147.565290] [041/162] (858s left) gem_softpin (allocator-basic-reserve)
[147.976136] Starting subtest: allocator-basic-reserve
[148.547353] Subtest allocator-basic-reserve: SUCCESS (0.563s)
[148.810668] [042/162] (856s left) gem_softpin (safe-alignment)
[149.219832] Starting subtest: safe-alignment
[149.331835] Subtest safe-alignment: SUCCESS (0.112s)
[151.347279] [043/162] (854s left) gem_sync (basic-all)
[151.819203] Starting subtest: basic-all
[155.149213] Subtest basic-all: SUCCESS (3.348s)
[155.444490] [044/162] (850s left) gem_sync (basic-each)
[155.892486] Starting subtest: basic-each
[158.825810] Subtest basic-each: SUCCESS (2.944s)
[159.128804] [045/162] (846s left) gem_tiled_blits (basic)
[159.545333] Subtest basic: SKIP (0.000s)
[159.674262] [046/162] (846s left) gem_tiled_fence_blits (basic)
[160.098882] Subtest basic: SKIP (0.000s)
[160.230570] [047/162] (845s left) gem_tiled_pread_basic
[160.752492] [048/162] (845s left) gem_wait (busy@all-engines)
[161.209221] Starting subtest: busy
[161.216363] Starting dynamic subtest: all-engines
[163.156059] Dynamic subtest all-engines: SUCCESS (1.938s)
[163.162914] Subtest busy: SUCCESS (1.939s)
[163.524249] [049/162] (842s left) gem_wait (wait@all-engines)
[163.996962] Starting subtest: wait
[164.004240] Starting dynamic subtest: all-engines
[165.132168] Dynamic subtest all-engines: SUCCESS (1.134s)
[165.139173] Subtest wait: SUCCESS (1.136s)
[165.511838] [050/162] (840s left) i915_getparams_basic (basic-eu-total)
[165.891367] Starting subtest: basic-eu-total
[165.906368] Subtest basic-eu-total: SUCCESS (0.000s)
[166.056751] [051/162] (840s left) i915_getparams_basic (basic-subslice-total)
[166.443806] Starting subtest: basic-subslice-total
[166.458862] Subtest basic-subslice-total: SUCCESS (0.000s)
[166.607789] [052/162] (839s left) i915_hangman (error-state-basic)
[167.053576] Starting subtest: error-state-basic
[168.171281] Subtest error-state-basic: SUCCESS (1.119s)
[168.372699] [053/162] (838s left) i915_pciid
[168.915439] [054/162] (837s left) kms_addfb_basic (addfb25-bad-modifier)
[169.303451] Starting subtest: addfb25-bad-modifier
[169.310355] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[169.604987] [055/162] (837s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[170.002751] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[170.273396] [056/162] (836s left) kms_addfb_basic (addfb25-modifier-no-flag)
[170.670439] Starting subtest: addfb25-modifier-no-flag
[170.677383] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[170.947809] [057/162] (836s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[171.339334] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[171.593321] [058/162] (835s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[171.976642] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[172.235512] [059/162] (834s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[172.724936] Starting subtest: addfb25-yf-tiled-legacy
[172.731481] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[172.873668] [060/162] (834s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[173.366801] Starting subtest: addfb25-y-tiled-legacy
[173.373417] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[173.516717] [061/162] (833s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[174.016182] Starting subtest: addfb25-y-tiled-small-legacy
[174.028823] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[174.168217] [062/162] (833s left) kms_addfb_basic (bad-pitch-0)
[174.557342] Starting subtest: bad-pitch-0
[174.563755] Subtest bad-pitch-0: SUCCESS (0.000s)
[174.830533] [063/162] (832s left) kms_addfb_basic (bad-pitch-1024)
[175.204186] Starting subtest: bad-pitch-1024
[175.210600] Subtest bad-pitch-1024: SUCCESS (0.000s)
[175.455241] [064/162] (832s left) kms_addfb_basic (bad-pitch-128)
[175.833122] Starting subtest: bad-pitch-128
[175.839756] Subtest bad-pitch-128: SUCCESS (0.000s)
[176.110118] [065/162] (831s left) kms_addfb_basic (bad-pitch-256)
[176.486606] Starting subtest: bad-pitch-256
[176.493754] Subtest bad-pitch-256: SUCCESS (0.000s)
[176.770217] [066/162] (830s left) kms_addfb_basic (bad-pitch-32)
[177.164928] Starting subtest: bad-pitch-32
[177.171891] Subtest bad-pitch-32: SUCCESS (0.000s)
[177.440703] [067/162] (830s left) kms_addfb_basic (bad-pitch-63)
[177.827668] Starting subtest: bad-pitch-63
[177.835116] Subtest bad-pitch-63: SUCCESS (0.000s)
[178.120765] [068/162] (829s left) kms_addfb_basic (bad-pitch-65536)
[178.509244] Starting subtest: bad-pitch-65536
[178.516254] Subtest bad-pitch-65536: SUCCESS (0.001s)
[178.810811] [069/162] (829s left) kms_addfb_basic (bad-pitch-999)
[179.203948] Starting subtest: bad-pitch-999
[179.211314] Subtest bad-pitch-999: SUCCESS (0.000s)
[179.487480] [070/162] (828s left) kms_addfb_basic (basic)
[179.867359] Starting subtest: basic
[179.874659] Subtest basic: SUCCESS (0.000s)
[180.159501] [071/162] (828s left) kms_addfb_basic (basic-x-tiled-legacy)
[180.568830] Starting subtest: basic-x-tiled-legacy
[180.586055] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[180.839479] [072/162] (827s left) kms_addfb_basic (basic-y-tiled-legacy)
[181.239297] Starting subtest: basic-y-tiled-legacy
[181.253573] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[181.506186] [073/162] (826s left) kms_addfb_basic (bo-too-small)
[181.994900] Starting subtest: bo-too-small
[182.002125] Subtest bo-too-small: SUCCESS (0.001s)
[182.179638] [074/162] (826s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[182.676453] Starting subtest: bo-too-small-due-to-tiling
[182.689926] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[182.853809] [075/162] (825s left) kms_addfb_basic (clobberred-modifier)
[183.233181] Starting subtest: clobberred-modifier
[183.246656] Subtest clobberred-modifier: SKIP (0.000s)
[183.492898] [076/162] (825s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[183.876837] Starting subtest: framebuffer-vs-set-tiling
[183.890222] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[184.161208] [077/162] (824s left) kms_addfb_basic (invalid-get-prop)
[184.546519] Starting subtest: invalid-get-prop
[184.553441] Subtest invalid-get-prop: SUCCESS (0.000s)
[184.819344] [078/162] (824s left) kms_addfb_basic (invalid-get-prop-any)
[185.207431] Starting subtest: invalid-get-prop-any
[185.214393] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[185.493431] [079/162] (823s left) kms_addfb_basic (invalid-set-prop)
[185.870884] Starting subtest: invalid-set-prop
[185.878233] Subtest invalid-set-prop: SUCCESS (0.000s)
[186.146630] [080/162] (822s left) kms_addfb_basic (invalid-set-prop-any)
[186.527380] Starting subtest: invalid-set-prop-any
[186.534400] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[186.801408] [081/162] (822s left) kms_addfb_basic (no-handle)
[187.185930] Starting subtest: no-handle
[187.192758] Subtest no-handle: SUCCESS (0.000s)
[187.456281] [082/162] (821s left) kms_addfb_basic (size-max)
[187.944983] Starting subtest: size-max
[187.951869] Subtest size-max: SUCCESS (0.000s)
[188.121139] [083/162] (821s left) kms_addfb_basic (small-bo)
[188.617658] Starting subtest: small-bo
[188.624538] Subtest small-bo: SUCCESS (0.000s)
[188.797615] [084/162] (820s left) kms_addfb_basic (tile-pitch-mismatch)
[189.198704] Starting subtest: tile-pitch-mismatch
[189.212986] Subtest tile-pitch-mismatch: SKIP (0.000s)
[189.489647] [085/162] (820s left) kms_addfb_basic (too-high)
[189.991389] Starting subtest: too-high
[189.998354] Subtest too-high: SUCCESS (0.004s)
[190.155433] [086/162] (819s left) kms_addfb_basic (too-wide)
[190.661059] Starting subtest: too-wide
[190.667867] Subtest too-wide: SUCCESS (0.000s)
[190.818295] [087/162] (818s left) kms_addfb_basic (unused-handle)
[191.201235] Starting subtest: unused-handle
[191.208554] Subtest unused-handle: SUCCESS (0.000s)
[191.489669] [088/162] (818s left) kms_addfb_basic (unused-modifier)
[191.877998] Starting subtest: unused-modifier
[191.885304] Subtest unused-modifier: SUCCESS (0.000s)
[192.159727] [089/162] (817s left) kms_addfb_basic (unused-offsets)
[192.538836] Starting subtest: unused-offsets
[192.545851] Subtest unused-offsets: SUCCESS (0.000s)
[192.830612] [090/162] (817s left) kms_addfb_basic (unused-pitches)
[193.210584] Starting subtest: unused-pitches
[193.217542] Subtest unused-pitches: SUCCESS (0.000s)
[193.487721] [091/162] (816s left) kms_busy (basic)
[194.009141] Starting subtest: basic
[194.016165] Starting dynamic subtest: flip
[195.735153] Dynamic subtest flip: SUCCESS (1.721s)
[195.780162] Starting dynamic subtest: modeset
[200.588636] Dynamic subtest modeset: SUCCESS (4.852s)
[200.595413] Subtest basic: SUCCESS (6.581s)
[201.549679] [092/162] (808s left) kms_prop_blob (basic)
[201.948536] Starting subtest: basic
[201.955659] Subtest basic: SUCCESS (0.000s)
[202.092259] [093/162] (808s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[202.676895] Starting subtest: basic-busy-flip-before-cursor-atomic
[202.690841] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[203.001401] [094/162] (807s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[203.578215] Starting subtest: basic-busy-flip-before-cursor-legacy
[203.593309] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[203.898703] [095/162] (806s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[204.479993] Starting subtest: basic-flip-after-cursor-atomic
[205.855302] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.374s)
[206.801727] [096/162] (803s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[207.388062] Starting subtest: basic-flip-after-cursor-legacy
[208.809610] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.421s)
[209.765968] [097/162] (800s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[210.366074] Starting subtest: basic-flip-after-cursor-varying-size
[211.766598] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.401s)
[212.713228] [098/162] (798s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[213.287394] Starting subtest: basic-flip-before-cursor-atomic
[214.692995] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.409s)
[215.650282] [099/162] (795s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[216.238464] Starting subtest: basic-flip-before-cursor-legacy
[217.600146] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.363s)
[218.557969] [100/162] (792s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[219.141506] Starting subtest: basic-flip-before-cursor-varying-size
[220.579831] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.443s)
[221.534536] [101/162] (789s left) kms_flip (basic-flip-vs-dpms)
[221.954284] Starting subtest: basic-flip-vs-dpms
[221.972630] Starting dynamic subtest: A-eDP1
[225.371666] Dynamic subtest A-eDP1: SUCCESS (3.398s)
[225.414416] Starting dynamic subtest: B-eDP1
[227.925160] Dynamic subtest B-eDP1: SUCCESS (2.545s)
[227.969285] Starting dynamic subtest: C-eDP1
[230.455262] Dynamic subtest C-eDP1: SUCCESS (2.530s)
[230.499473] Starting dynamic subtest: D-eDP1
[233.020963] Dynamic subtest D-eDP1: SUCCESS (2.565s)
[233.043757] Subtest basic-flip-vs-dpms: SUCCESS (11.103s)
[233.968877] [102/162] (777s left) kms_flip (basic-flip-vs-modeset)
[234.382423] Starting subtest: basic-flip-vs-modeset
[234.401577] Starting dynamic subtest: A-eDP1
[237.727650] Dynamic subtest A-eDP1: SUCCESS (3.319s)
[237.770629] Starting dynamic subtest: B-eDP1
[240.159787] Dynamic subtest B-eDP1: SUCCESS (2.436s)
[240.202201] Starting dynamic subtest: C-eDP1
[242.583312] Dynamic subtest C-eDP1: SUCCESS (2.418s)
[242.625803] Starting dynamic subtest: D-eDP1
[244.998225] Dynamic subtest D-eDP1: SUCCESS (2.413s)
[245.022407] Subtest basic-flip-vs-modeset: SUCCESS (10.652s)
[245.951979] [103/162] (765s left) kms_flip (basic-flip-vs-wf_vblank)
[246.385626] Starting subtest: basic-flip-vs-wf_vblank
[246.405884] Starting dynamic subtest: A-eDP1
[248.896876] Dynamic subtest A-eDP1: SUCCESS (2.491s)
[248.945331] Starting dynamic subtest: B-eDP1
[251.238084] Dynamic subtest B-eDP1: SUCCESS (2.338s)
[251.278644] Starting dynamic subtest: C-eDP1
[253.570740] Dynamic subtest C-eDP1: SUCCESS (2.326s)
[253.617473] Starting dynamic subtest: D-eDP1
[255.903232] Dynamic subtest D-eDP1: SUCCESS (2.329s)
[255.929636] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.558s)
[257.499334] [104/162] (753s left) kms_flip (basic-plain-flip)
[257.920125] Starting subtest: basic-plain-flip
[257.934598] Starting dynamic subtest: A-eDP1
[260.200797] Dynamic subtest A-eDP1: SUCCESS (2.266s)
[260.244171] Starting dynamic subtest: B-eDP1
[262.285967] Dynamic subtest B-eDP1: SUCCESS (2.081s)
[262.329865] Starting dynamic subtest: C-eDP1
[264.375147] Dynamic subtest C-eDP1: SUCCESS (2.076s)
[264.423999] Starting dynamic subtest: D-eDP1
[266.451722] Dynamic subtest D-eDP1: SUCCESS (2.076s)
[266.474068] Subtest basic-plain-flip: SUCCESS (8.571s)
[268.046501] [105/162] (743s left) kms_force_connector_basic (force-connector-state)
[268.452048] Starting subtest: force-connector-state
[270.913320] Subtest force-connector-state: SUCCESS (2.464s)
[271.815438] [106/162] (739s left) kms_force_connector_basic (force-edid)
[272.212779] Starting subtest: force-edid
[272.505930] Subtest force-edid: SUCCESS (0.300s)
[272.756867] [107/162] (738s left) kms_force_connector_basic (force-load-detect)
[273.143639] Starting subtest: force-load-detect
[273.155464] Subtest force-load-detect: SKIP (0.000s)
[273.378778] [108/162] (738s left) kms_force_connector_basic (prune-stale-modes)
[273.775592] Starting subtest: prune-stale-modes
[273.982537] Subtest prune-stale-modes: SKIP (0.208s)
[274.211682] [109/162] (737s left) kms_frontbuffer_tracking (basic)
[274.743450] Starting subtest: basic
[283.676366] Subtest basic: SUCCESS (8.937s)
[283.886963] [110/162] (728s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[284.396255] Starting subtest: compare-crc-sanitycheck-xr24
[284.406792] Starting dynamic subtest: pipe-A-eDP-1
[285.613974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.209s)
[285.659241] Starting dynamic subtest: pipe-B-eDP-1
[287.477856] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.855s)
[287.521275] Starting dynamic subtest: pipe-C-eDP-1
[289.598880] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.110s)
[289.642915] Starting dynamic subtest: pipe-D-eDP-1
[292.000831] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.390s)
[292.008159] Subtest compare-crc-sanitycheck-xr24: SUCCESS (7.606s)
[292.953808] [111/162] (719s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[293.385781] Starting subtest: compare-crc-sanitycheck-nv12
[293.395493] Starting dynamic subtest: pipe-A-eDP-1
[294.388810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.993s)
[294.440491] Starting dynamic subtest: pipe-B-eDP-1
[295.844516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[295.895732] Starting dynamic subtest: pipe-C-eDP-1
[297.229464] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[297.285310] Starting dynamic subtest: pipe-D-eDP-1
[298.524828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[298.532130] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.137s)
[299.477485] [112/162] (712s left) kms_pipe_crc_basic (hang-read-crc)
[299.978134] Starting subtest: hang-read-crc
[299.985183] Starting dynamic subtest: pipe-A-eDP-1
[304.245052] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.256s)
[304.297189] Starting dynamic subtest: pipe-B-eDP-1
[309.354968] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.097s)
[309.405684] Starting dynamic subtest: pipe-C-eDP-1
[314.957775] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.591s)
[315.007828] Starting dynamic subtest: pipe-D-eDP-1
[320.878138] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.907s)
[320.885211] Subtest hang-read-crc: SUCCESS (20.896s)
[321.833630] [113/162] (690s left) kms_pipe_crc_basic (nonblocking-crc)
[322.328167] Starting subtest: nonblocking-crc
[322.335186] Starting dynamic subtest: pipe-A-eDP-1
[323.667770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.334s)
[323.724831] Starting dynamic subtest: pipe-B-eDP-1
[325.678872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.993s)
[325.726649] Starting dynamic subtest: pipe-C-eDP-1
[327.947857] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[327.995546] Starting dynamic subtest: pipe-D-eDP-1
[330.405330] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.448s)
[330.411703] Subtest nonblocking-crc: SUCCESS (8.079s)
[331.353444] [114/162] (680s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[331.854128] Starting subtest: nonblocking-crc-frame-sequence
[331.860719] Starting dynamic subtest: pipe-A-eDP-1
[333.140718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.277s)
[333.195752] Starting dynamic subtest: pipe-B-eDP-1
[335.115755] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.966s)
[335.174448] Starting dynamic subtest: pipe-C-eDP-1
[337.341397] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.208s)
[337.389801] Starting dynamic subtest: pipe-D-eDP-1
[339.834392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.485s)
[339.841749] Subtest nonblocking-crc-frame-sequence: SUCCESS (7.981s)
[340.786350] [115/162] (671s left) kms_pipe_crc_basic (read-crc)
[341.295680] Starting subtest: read-crc
[341.302612] Starting dynamic subtest: pipe-A-eDP-1
[342.572197] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.274s)
[342.631298] Starting dynamic subtest: pipe-B-eDP-1
[344.452623] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.866s)
[344.511146] Starting dynamic subtest: pipe-C-eDP-1
[346.615313] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.153s)
[346.672383] Starting dynamic subtest: pipe-D-eDP-1
[349.196741] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[349.203883] Subtest read-crc: SUCCESS (7.905s)
[350.161988] [116/162] (662s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[350.663237] Starting subtest: read-crc-frame-sequence
[350.670147] Starting dynamic subtest: pipe-A-eDP-1
[351.917155] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.241s)
[351.964689] Starting dynamic subtest: pipe-B-eDP-1
[353.892182] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.963s)
[353.941264] Starting dynamic subtest: pipe-C-eDP-1
[356.183656] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.285s)
[356.242765] Starting dynamic subtest: pipe-D-eDP-1
[358.618984] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[358.626155] Subtest read-crc-frame-sequence: SUCCESS (7.953s)
[359.567117] [117/162] (653s left) kms_psr (primary_page_flip)
[360.089547] Starting subtest: primary_page_flip
[363.160128] Subtest primary_page_flip: SUCCESS (3.069s)
[364.113162] [118/162] (648s left) kms_psr (cursor_plane_move)
[364.610972] Starting subtest: cursor_plane_move
[367.739958] Subtest cursor_plane_move: SUCCESS (3.126s)
[368.682485] [119/162] (644s left) kms_psr (sprite_plane_onoff)
[369.206422] Starting subtest: sprite_plane_onoff
[372.310689] Subtest sprite_plane_onoff: SUCCESS (3.106s)
[373.254415] [120/162] (639s left) kms_psr (primary_mmap_gtt)
[373.751739] Starting subtest: primary_mmap_gtt
[376.635480] Subtest primary_mmap_gtt: SKIP (2.868s)
[376.989549] [121/162] (635s left) kms_setmode (basic-clone-single-crtc)
[377.375597] Starting subtest: basic-clone-single-crtc
[377.396449] Subtest basic-clone-single-crtc: SKIP (0.003s)
[377.534176] [122/162] (635s left) i915_pm_backlight (basic-brightness)
[378.024632] Starting subtest: basic-brightness
[378.384982] Starting dynamic subtest: eDP-1
[379.073570] Dynamic subtest eDP-1: SUCCESS (0.694s)
[379.080798] Subtest basic-brightness: SUCCESS (1.054s)
[380.033816] [123/162] (633s left) i915_pm_rpm (basic-pci-d3-state)
[386.101330] Starting subtest: basic-pci-d3-state
[391.273452] Subtest basic-pci-d3-state: SUCCESS (5.172s)
[391.494313] [124/162] (621s left) i915_pm_rpm (basic-rte)
[391.871103] Starting subtest: basic-rte
[402.282961] Subtest basic-rte: SUCCESS (10.413s)
[404.183452] [125/162] (609s left) i915_pm_rps (basic-api)
[404.604273] Starting subtest: basic-api
[404.618393] Subtest basic-api: SKIP (0.002s)
[404.777233] [126/162] (608s left) prime_self_import (basic-llseek-bad)
[405.159197] Starting subtest: basic-llseek-bad
[405.173277] Subtest basic-llseek-bad: SUCCESS (0.010s)
[405.353574] [127/162] (608s left) prime_self_import (basic-llseek-size)
[405.738448] Starting subtest: basic-llseek-size
[405.753835] Subtest basic-llseek-size: SUCCESS (0.015s)
[405.936308] [128/162] (607s left) prime_self_import (basic-with_fd_dup)
[406.326055] Starting subtest: basic-with_fd_dup
[406.351318] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[406.523373] [129/162] (607s left) prime_self_import (basic-with_one_bo)
[406.904186] Starting subtest: basic-with_one_bo
[406.927669] Subtest basic-with_one_bo: SUCCESS (0.017s)
[407.075580] [130/162] (606s left) prime_self_import (basic-with_one_bo_two_files)
[407.451759] Starting subtest: basic-with_one_bo_two_files
[407.466925] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[407.640115] [131/162] (606s left) prime_self_import (basic-with_two_bos)
[408.014975] Starting subtest: basic-with_two_bos
[408.029290] Subtest basic-with_two_bos: SUCCESS (0.016s)
[408.229388] [132/162] (605s left) prime_vgem (basic-fence-flip)
[408.683140] Starting subtest: basic-fence-flip
[409.440339] Subtest basic-fence-flip: SUCCESS (0.757s)
[409.649184] [133/162] (604s left) prime_vgem (basic-fence-mmap)
[410.081610] Starting subtest: basic-fence-mmap
[410.095863] Subtest basic-fence-mmap: SKIP (0.000s)
[410.273941] [134/162] (603s left) prime_vgem (basic-fence-read)
[410.720825] Starting subtest: basic-fence-read
[410.754973] Subtest basic-fence-read: SKIP (0.028s)
[410.912705] [135/162] (603s left) prime_vgem (basic-gtt)
[411.356114] Starting subtest: basic-gtt
[411.370237] Subtest basic-gtt: SKIP (0.000s)
[411.509273] [136/162] (602s left) prime_vgem (basic-read)
[411.952968] Starting subtest: basic-read
[411.987246] Subtest basic-read: SKIP (0.028s)
[412.173266] [137/162] (602s left) prime_vgem (basic-write)
[412.588833] Starting subtest: basic-write
[412.620645] Subtest basic-write: SKIP (0.026s)
[412.823610] [138/162] (601s left) vgem_basic (setversion)
[413.249967] Starting subtest: setversion
[413.264424] Subtest setversion: SUCCESS (0.000s)
[413.387502] [139/162] (601s left) vgem_basic (create)
[413.802371] Starting subtest: create
[413.809387] Subtest create: SUCCESS (0.001s)
[413.956114] [140/162] (600s left) vgem_basic (debugfs)
[414.376996] Starting subtest: debugfs
[414.384143] Subtest debugfs: SUCCESS (0.001s)
[414.527773] [141/162] (600s left) vgem_basic (dmabuf-export)
[414.947750] Starting subtest: dmabuf-export
[414.961471] Subtest dmabuf-export: SUCCESS (0.022s)
[415.167150] [142/162] (599s left) vgem_basic (dmabuf-fence)
[415.586861] Starting subtest: dmabuf-fence
[415.594086] Subtest dmabuf-fence: SUCCESS (0.003s)
[415.736168] [143/162] (599s left) vgem_basic (dmabuf-fence-before)
[416.154865] Starting subtest: dmabuf-fence-before
[416.161997] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[416.308651] [144/162] (598s left) vgem_basic (dmabuf-mmap)
[416.726315] Starting subtest: dmabuf-mmap
[416.772123] Subtest dmabuf-mmap: SUCCESS (0.057s)
[416.934269] [145/162] (598s left) vgem_basic (mmap)
[417.342755] Starting subtest: mmap
[417.368060] Subtest mmap: SUCCESS (0.037s)
[417.529247] [146/162] (597s left) vgem_basic (second-client)
[417.943952] Starting subtest: second-client
[417.992552] Subtest second-client: SUCCESS (0.044s)
[418.146274] [147/162] (597s left) vgem_basic (sysfs)
[418.565963] Starting subtest: sysfs
[418.573258] Subtest sysfs: SUCCESS (0.002s)
[418.718643] [148/162] (596s left) core_hotunplug (unbind-rebind)
[419.261128] Starting subtest: unbind-rebind
[426.992515] Subtest unbind-rebind: SUCCESS (7.733s)
[427.100889] [149/162] (588s left) vgem_basic (unload)
[427.477762] Starting subtest: unload
[456.686467] Subtest unload: SUCCESS (29.201s)
[456.937922] [150/162] (558s left) i915_module_load (reload)
[457.325092] Starting subtest: reload
[464.707419] Subtest reload: SUCCESS (7.381s)
[464.782650] [151/162] (551s left) gem_lmem_swapping (basic)
[465.152392] Subtest basic: SKIP (0.000s)
[465.267491] [152/162] (550s left) gem_lmem_swapping (parallel-random-engines)
[465.675486] Subtest parallel-random-engines: SKIP (0.000s)
[465.777384] [153/162] (550s left) gem_lmem_swapping (random-engines)
[466.188601] Subtest random-engines: SKIP (0.000s)
[466.292509] [154/162] (549s left) gem_lmem_swapping (verify-random)
[466.709474] Subtest verify-random: SKIP (0.000s)
[466.817666] [155/162] (549s left) i915_pm_rpm (module-reload)
[469.889018] Starting subtest: module-reload
[500.421297] Subtest module-reload: SUCCESS (30.527s)
[500.496464] [156/162] (515s left) i915_selftest (live)
[500.900572] Starting subtest: live
[500.907565] Starting dynamic subtest: sanitycheck
[504.981206] Dynamic subtest sanitycheck: SUCCESS (4.071s)
[505.015294] Starting dynamic subtest: uncore
[509.000318] Dynamic subtest uncore: SUCCESS (4.015s)
[509.034519] Starting dynamic subtest: workarounds
[514.216993] Dynamic subtest workarounds: SUCCESS (5.213s)
[514.251425] Starting dynamic subtest: gt_engines
[518.526299] Dynamic subtest gt_engines: SUCCESS (4.305s)
[518.561931] Starting dynamic subtest: gt_timelines
[538.743224] Dynamic subtest gt_timelines: SUCCESS (20.213s)
[538.777821] Starting dynamic subtest: gt_contexts
[542.814074] Dynamic subtest gt_contexts: SUCCESS (4.066s)
[542.850401] Starting dynamic subtest: gt_lrc
[548.803465] Dynamic subtest gt_lrc: SUCCESS (5.986s)
[548.837806] Starting dynamic subtest: gt_mocs
[567.430488] Dynamic subtest gt_mocs: FAIL (17.566s)
[567.460553] Starting dynamic subtest: gt_pm
[571.255257] Dynamic subtest gt_pm: SUCCESS (4.876s)
[571.313394] Starting dynamic subtest: gt_heartbeat
[575.385867] Dynamic subtest gt_heartbeat: SUCCESS (4.127s)
[575.422115] Starting dynamic subtest: gt_tlb
[581.434633] Dynamic subtest gt_tlb: SUCCESS (6.044s)
[581.468253] Starting dynamic subtest: requests
[615.478227] Dynamic subtest requests: FAIL (33.061s)
[615.514238] Starting dynamic subtest: migrate
[623.442211] Dynamic subtest migrate: SUCCESS (8.936s)
[623.476788] Starting dynamic subtest: active
[627.499357] Dynamic subtest active: SUCCESS (4.053s)
[627.536153] Starting dynamic subtest: objects
[634.415099] Dynamic subtest objects: SUCCESS (6.911s)
[634.449933] Starting dynamic subtest: mman
[642.342347] Dynamic subtest mman: SUCCESS (7.924s)
[642.377378] Starting dynamic subtest: dmabuf
[646.467672] Dynamic subtest dmabuf: SUCCESS (4.121s)
[646.526816] Starting dynamic subtest: vma
[650.491447] Dynamic subtest vma: SUCCESS (4.020s)
[650.526127] Starting dynamic subtest: coherency
[657.004455] Dynamic subtest coherency: SUCCESS (6.509s)
[657.038171] Starting dynamic subtest: gtt
[668.906969] Dynamic subtest gtt: SUCCESS (11.897s)
[668.965173] Starting dynamic subtest: gem
[675.764911] Dynamic subtest gem: SUCCESS (6.861s)
[675.800332] Starting dynamic subtest: evict
[682.152959] Dynamic subtest evict: SUCCESS (6.377s)
[682.188157] Starting dynamic subtest: hugepages
[692.327973] Dynamic subtest hugepages: SUCCESS (10.171s)
[692.367984] Starting dynamic subtest: gem_contexts
[744.111692] Dynamic subtest gem_contexts: SUCCESS (51.776s)
[744.147372] Starting dynamic subtest: client
[748.262937] Dynamic subtest client: SUCCESS (4.149s)
[748.299875] Starting dynamic subtest: gem_migrate
[752.360149] Dynamic subtest gem_migrate: SUCCESS (4.092s)
[752.397895] Starting dynamic subtest: reset
[756.483909] Dynamic subtest reset: SUCCESS (4.124s)
[756.519800] Starting dynamic subtest: memory_region
[760.620689] Dynamic subtest memory_region: SUCCESS (4.132s)
[760.656447] Starting dynamic subtest: hangcheck
[779.179157] Dynamic subtest hangcheck: SUCCESS (18.554s)
[779.217724] Starting dynamic subtest: execlists
[783.236275] Dynamic subtest execlists: SUCCESS (4.053s)
[783.272250] Starting dynamic subtest: ring_submission
[787.197200] Dynamic subtest ring_submission: SUCCESS (3.957s)
[787.232973] Starting dynamic subtest: perf
[791.416225] Dynamic subtest perf: SUCCESS (4.215s)
[791.452217] Starting dynamic subtest: slpc
[806.707957] Dynamic subtest slpc: SUCCESS (15.288s)
[806.744497] Starting dynamic subtest: guc
[812.700903] Dynamic subtest guc: SUCCESS (5.990s)
[812.736582] Starting dynamic subtest: guc_multi_lrc
[816.644855] Dynamic subtest guc_multi_lrc: SUCCESS (3.939s)
[816.695203] Starting dynamic subtest: guc_hang
[821.356600] Dynamic subtest guc_hang: SUCCESS (4.707s)
[821.394452] Starting dynamic subtest: late_gt_pm
[825.356960] Dynamic subtest late_gt_pm: SUCCESS (3.996s)
[825.363665] Subtest live: FAIL (324.451s)
[825.636105] [157/162] (190s left) dmabuf (all-tests)
[826.024747] Starting subtest: all-tests
[826.030844] Starting dynamic subtest: sanitycheck
[826.092063] Dynamic subtest sanitycheck: SUCCESS (0.074s)
[826.126508] Starting dynamic subtest: dma_fence
[826.303248] Dynamic subtest dma_fence: SUCCESS (0.208s)
[826.337226] Starting dynamic subtest: dma_fence_chain
[844.562258] Dynamic subtest dma_fence_chain: SUCCESS (18.247s)
[844.603975] Starting dynamic subtest: dma_fence_unwrap
[844.647089] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[844.677200] Starting dynamic subtest: dma_resv
[844.738221] Dynamic subtest dma_resv: SUCCESS (0.089s)
[844.745231] Subtest all-tests: SUCCESS (18.724s)
[844.818858] [158/162] (171s left) i915_suspend (basic-s2idle-without-i915)
[845.198527] Starting subtest: basic-s2idle-without-i915
[871.397133] Subtest basic-s2idle-without-i915: SUCCESS (26.195s)
[876.038372] [159/162] (144s left) i915_suspend (basic-s3-without-i915)
[876.427841] Starting subtest: basic-s3-without-i915
[879.874139] Subtest basic-s3-without-i915: SKIP (3.443s)
[882.537075] [160/162] (138s left) gem_exec_suspend (basic-s0)
[882.928663] Starting subtest: basic-S0
[882.935770] Starting dynamic subtest: smem
[914.196800] Dynamic subtest smem: SUCCESS (31.259s)
[914.204262] Subtest basic-S0: SUCCESS (31.262s)
[916.445617] [161/162] (106s left) gem_exec_suspend (basic-s3)
[916.892160] Starting subtest: basic-S3
[916.899100] Starting dynamic subtest: smem
[948.181647] Dynamic subtest smem: SUCCESS (31.279s)
[948.188649] Subtest basic-S3: SUCCESS (31.283s)
[950.151438] [162/162] ( 74s left) kms_pipe_crc_basic (suspend-read-crc)
[950.677335] Starting subtest: suspend-read-crc
[950.695127] Starting dynamic subtest: pipe-A-eDP-1
[973.052165] Dynamic subtest pipe-A-eDP-1: SUCCESS (22.364s)
[973.103855] Starting dynamic subtest: pipe-B-eDP-1
[992.729916] Dynamic subtest pipe-B-eDP-1: SUCCESS (19.669s)
[992.790447] Starting dynamic subtest: pipe-C-eDP-1
[1012.671584] Dynamic subtest pipe-C-eDP-1: SUCCESS (19.922s)
[1012.723803] Starting dynamic subtest: pipe-D-eDP-1
[1033.805121] Dynamic subtest pipe-D-eDP-1: SUCCESS (21.126s)
[1033.811994] Subtest suspend-read-crc: SUCCESS (83.126s)
[1034.711724] Overall timeout time exceeded, stopping.
[1034.712946] Closing watchdogs
Done.