[52.634744] Initializing watchdogs
[52.635087]   /dev/watchdog0
[52.656897] [001/165] (960s left) i915_module_load (load)
[52.914225] Starting subtest: load
[56.481339] Subtest load: SUCCESS (3.567s)
[56.592559] [002/165] (956s left) core_auth (basic-auth)
[56.978978] Starting subtest: basic-auth
[56.984118] Subtest basic-auth: SUCCESS (0.008s)
[57.169249] [003/165] (956s left) debugfs_test (read_all_entries)
[57.478965] Starting subtest: read_all_entries
[57.633598] Subtest read_all_entries: SUCCESS (0.157s)
[58.215639] [004/165] (955s left) debugfs_test (basic-hwmon)
[58.463732] Starting subtest: basic-hwmon
[58.471735] Subtest basic-hwmon: SKIP (0.000s)
[59.050109] [005/165] (954s left) fbdev (eof)
[59.327088] Starting subtest: eof
[59.328955] Subtest eof: SUCCESS (0.005s)
[59.445166] [006/165] (954s left) fbdev (info)
[59.670207] Starting subtest: info
[59.672401] Subtest info: SUCCESS (0.000s)
[59.811253] [007/165] (953s left) fbdev (nullptr)
[60.049081] Starting subtest: nullptr
[60.050693] Subtest nullptr: SUCCESS (0.000s)
[60.180571] [008/165] (953s left) fbdev (read)
[60.416146] Starting subtest: read
[68.953198] Subtest read: SUCCESS (8.536s)
[69.079765] [009/165] (944s left) fbdev (write)
[69.315411] Starting subtest: write
[73.652049] Subtest write: SUCCESS (4.333s)
[73.774220] [010/165] (939s left) gem_basic (bad-close)
[74.007156] Starting subtest: bad-close
[74.012449] Subtest bad-close: SUCCESS (0.000s)
[74.152635] [011/165] (939s left) gem_basic (create-close)
[74.386077] Starting subtest: create-close
[74.393997] Subtest create-close: SUCCESS (0.000s)
[74.542670] [012/165] (939s left) gem_basic (create-fd-close)
[74.772598] Starting subtest: create-fd-close
[74.776828] Subtest create-fd-close: SUCCESS (0.000s)
[74.941955] [013/165] (938s left) gem_busy (busy@all-engines)
[75.211492] Starting subtest: busy
[75.217584] Starting dynamic subtest: all-engines
[75.364000] Dynamic subtest all-engines: SUCCESS (0.154s)
[75.367567] Subtest busy: SUCCESS (0.155s)
[75.852976] [014/165] (938s left) gem_close_race (basic-process)
[76.147597] Starting subtest: basic-process
[76.293568] Subtest basic-process: SUCCESS (0.150s)
[76.584840] [015/165] (937s left) gem_close_race (basic-threads)
[76.856864] Starting subtest: basic-threads
[78.055472] Subtest basic-threads: SUCCESS (1.199s)
[78.347131] [016/165] (935s left) gem_ctx_create (basic)
[78.620243] Starting subtest: basic
[78.621928] Subtest basic: SUCCESS (0.001s)
[78.911444] [017/165] (935s left) gem_ctx_create (basic-files)
[79.180239] Starting subtest: basic-files
[81.240844] Subtest basic-files: SUCCESS (2.063s)
[81.509344] [018/165] (932s left) gem_ctx_exec (basic)
[81.739780] Starting subtest: basic
[81.758152] Subtest basic: SUCCESS (0.015s)
[81.949625] [019/165] (932s left) gem_exec_basic (basic)
[82.207343] Starting subtest: basic
[82.209745] Starting dynamic subtest: rcs0-smem
[82.212825] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[82.244201] Starting dynamic subtest: bcs0-smem
[82.245665] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[82.262311] Starting dynamic subtest: vcs0-smem
[82.263792] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[82.280456] Starting dynamic subtest: vecs0-smem
[82.281920] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[82.283500] Subtest basic: SUCCESS (0.018s)
[82.512145] [020/165] (931s left) gem_exec_create (basic)
[82.775742] Starting subtest: basic
[82.780500] Starting dynamic subtest: smem
[84.861107] Dynamic subtest smem: SUCCESS (2.082s)
[84.862934] Subtest basic: SUCCESS (2.087s)
[85.148731] [021/165] (929s left) gem_exec_fence (basic-busy)
[85.684030] Starting subtest: basic-busy
[85.689876] Starting dynamic subtest: rcs0
[85.724729] Dynamic subtest rcs0: SUCCESS (0.032s)
[85.758755] Starting dynamic subtest: bcs0
[85.764311] Dynamic subtest bcs0: SUCCESS (0.024s)
[85.801959] Starting dynamic subtest: vcs0
[85.807244] Dynamic subtest vcs0: SUCCESS (0.028s)
[85.823987] Starting dynamic subtest: vecs0
[85.827116] Dynamic subtest vecs0: SUCCESS (0.025s)
[85.828715] Subtest basic-busy: SUCCESS (0.118s)
[86.718321] [022/165] (927s left) gem_exec_fence (basic-wait)
[87.158168] Starting subtest: basic-wait
[87.161833] Starting dynamic subtest: rcs0
[87.189822] Dynamic subtest rcs0: SUCCESS (0.029s)
[87.241244] Starting dynamic subtest: bcs0
[87.246176] Dynamic subtest bcs0: SUCCESS (0.031s)
[87.283068] Starting dynamic subtest: vcs0
[87.284674] Dynamic subtest vcs0: SUCCESS (0.031s)
[87.302704] Starting dynamic subtest: vecs0
[87.304400] Dynamic subtest vecs0: SUCCESS (0.026s)
[87.305903] Subtest basic-wait: SUCCESS (0.119s)
[87.983501] [023/165] (926s left) gem_exec_fence (basic-await)
[88.411811] Starting subtest: basic-await
[88.413671] Starting dynamic subtest: rcs0
[88.599493] Dynamic subtest rcs0: SUCCESS (0.190s)
[88.626227] Starting dynamic subtest: bcs0
[88.782505] Dynamic subtest bcs0: SUCCESS (0.176s)
[88.801300] Starting dynamic subtest: vcs0
[88.967398] Dynamic subtest vcs0: SUCCESS (0.184s)
[88.991123] Starting dynamic subtest: vecs0
[89.141960] Dynamic subtest vecs0: SUCCESS (0.178s)
[89.145880] Subtest basic-await: SUCCESS (0.732s)
[89.819376] [024/165] (924s left) gem_exec_fence (nb-await)
[90.240641] Starting subtest: nb-await
[90.242753] Starting dynamic subtest: rcs0
[90.325158] Dynamic subtest rcs0: SUCCESS (0.084s)
[90.344265] Starting dynamic subtest: bcs0
[90.410980] Dynamic subtest bcs0: SUCCESS (0.085s)
[90.429754] Starting dynamic subtest: vcs0
[90.496860] Dynamic subtest vcs0: SUCCESS (0.083s)
[90.515068] Starting dynamic subtest: vecs0
[90.577722] Dynamic subtest vecs0: SUCCESS (0.078s)
[90.579750] Subtest nb-await: SUCCESS (0.338s)
[91.279927] [025/165] (923s left) gem_exec_gttfill (basic)
[91.550889] Starting subtest: basic
[95.394402] Subtest basic: SKIP (3.818s)
[95.684758] [026/165] (918s left) gem_exec_parallel (engines)
[96.085501] Starting subtest: engines
[96.092153] Starting dynamic subtest: basic
[101.301219] Dynamic subtest basic: SUCCESS (5.215s)
[101.328618] Starting dynamic subtest: contexts
[109.933277] Dynamic subtest contexts: SUCCESS (8.625s)
[109.961713] Starting dynamic subtest: fds
[123.782125] Dynamic subtest fds: SUCCESS (13.854s)
[123.808535] Starting dynamic subtest: userptr
[129.036187] Dynamic subtest userptr: SUCCESS (5.248s)
[129.041641] Subtest engines: SUCCESS (32.949s)
[129.357219] [027/165] (885s left) gem_exec_store (basic)
[129.658449] Starting subtest: basic
[129.725556] Subtest basic: SUCCESS (0.065s)
[130.020878] [028/165] (884s left) gem_flink_basic (bad-flink)
[130.262267] Starting subtest: bad-flink
[130.264991] Subtest bad-flink: SUCCESS (0.000s)
[130.421270] [029/165] (884s left) gem_flink_basic (bad-open)
[130.654393] Starting subtest: bad-open
[130.657693] Subtest bad-open: SUCCESS (0.000s)
[130.815513] [030/165] (883s left) gem_flink_basic (basic)
[131.044636] Starting subtest: basic
[131.048445] Subtest basic: SUCCESS (0.000s)
[131.218521] [031/165] (883s left) gem_flink_basic (double-flink)
[131.443180] Starting subtest: double-flink
[131.445893] Subtest double-flink: SUCCESS (0.001s)
[131.617781] [032/165] (883s left) gem_flink_basic (flink-lifetime)
[131.848342] Starting subtest: flink-lifetime
[131.858813] Subtest flink-lifetime: SUCCESS (0.008s)
[132.015399] [033/165] (882s left) gem_huc_copy (huc-copy)
[132.251854] Subtest huc-copy: SKIP (0.000s)
[132.342333] [034/165] (882s left) gem_linear_blits (basic)
[134.387344] Subtest basic: SKIP (0.000s)
[134.578314] [035/165] (880s left) gem_mmap (basic)
[134.936212] Starting subtest: basic
[134.949636] Subtest basic: SUCCESS (0.002s)
[135.115245] [036/165] (880s left) gem_mmap_gtt (basic)
[135.346992] Starting subtest: basic
[135.351180] Subtest basic: SUCCESS (0.004s)
[135.515500] [037/165] (879s left) gem_render_linear_blits (basic)
[135.757056] Starting subtest: basic
[135.867514] Subtest basic: SUCCESS (0.103s)
[135.976320] [038/165] (879s left) gem_render_tiled_blits (basic)
[136.217573] Starting subtest: basic
[136.356141] Subtest basic: SUCCESS (0.131s)
[136.439339] [039/165] (878s left) gem_ringfill (basic-all)
[136.874545] Starting subtest: basic-all
[138.171222] Subtest basic-all: SUCCESS (1.297s)
[138.351196] [040/165] (876s left) gem_softpin (allocator-basic)
[138.588501] Starting subtest: allocator-basic
[138.874841] Subtest allocator-basic: SUCCESS (0.283s)
[139.111542] [041/165] (876s left) gem_softpin (allocator-basic-reserve)
[139.352663] Starting subtest: allocator-basic-reserve
[139.655547] Subtest allocator-basic-reserve: SUCCESS (0.290s)
[139.888514] [042/165] (875s left) gem_softpin (safe-alignment)
[140.135627] Starting subtest: safe-alignment
[140.182209] Subtest safe-alignment: SUCCESS (0.045s)
[140.349286] [043/165] (875s left) gem_sync (basic-all)
[140.614697] Starting subtest: basic-all
[143.337309] Subtest basic-all: SUCCESS (2.720s)
[143.618349] [044/165] (871s left) gem_sync (basic-each)
[143.894700] Starting subtest: basic-each
[146.663261] Subtest basic-each: SUCCESS (2.769s)
[146.950420] [045/165] (868s left) gem_tiled_blits (basic)
[148.945964] Subtest basic: SKIP (0.000s)
[149.043121] [046/165] (866s left) gem_tiled_fence_blits (basic)
[150.913365] Starting subtest: basic
[150.970820] Subtest basic: SUCCESS (0.054s)
[151.183596] [047/165] (864s left) gem_tiled_pread_basic
[152.423673] [048/165] (863s left) gem_wait (busy@all-engines)
[152.729238] Starting subtest: busy
[152.731427] Starting dynamic subtest: all-engines
[153.250106] Dynamic subtest all-engines: SUCCESS (0.528s)
[153.251679] Subtest busy: SUCCESS (0.530s)
[153.617306] [049/165] (862s left) gem_wait (wait@all-engines)
[153.906790] Starting subtest: wait
[153.908439] Starting dynamic subtest: all-engines
[154.948810] Dynamic subtest all-engines: SUCCESS (1.042s)
[154.950414] Subtest wait: SUCCESS (1.043s)
[155.326714] [050/165] (860s left) i915_getparams_basic (basic-eu-total)
[155.564300] Starting subtest: basic-eu-total
[155.568783] Subtest basic-eu-total: SUCCESS (0.000s)
[155.719304] [051/165] (860s left) i915_getparams_basic (basic-subslice-total)
[155.948158] Starting subtest: basic-subslice-total
[155.952340] Subtest basic-subslice-total: SUCCESS (0.000s)
[156.113164] [052/165] (859s left) i915_hangman (error-state-basic)
[156.384378] Starting subtest: error-state-basic
[156.412884] Subtest error-state-basic: SUCCESS (0.024s)
[156.587850] [053/165] (859s left) i915_pciid
[156.987244] [054/165] (859s left) kms_addfb_basic (addfb25-4-tiled)
[157.646442] Starting subtest: addfb25-4-tiled
[157.650261] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[157.818774] [055/165] (858s left) kms_addfb_basic (addfb25-bad-modifier)
[158.056599] Starting subtest: addfb25-bad-modifier
[158.059205] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[158.614848] [056/165] (857s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[158.842717] Starting subtest: addfb25-framebuffer-vs-set-tiling
[158.844353] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[159.412708] [057/165] (856s left) kms_addfb_basic (addfb25-modifier-no-flag)
[159.637638] Starting subtest: addfb25-modifier-no-flag
[159.641591] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[160.217263] [058/165] (856s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[160.445146] Starting subtest: addfb25-x-tiled-legacy
[160.446770] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[161.047603] [059/165] (855s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[161.267776] Starting subtest: addfb25-x-tiled-mismatch-legacy
[161.269683] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[161.852450] [060/165] (854s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[162.504116] Starting subtest: addfb25-yf-tiled-legacy
[162.505819] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[162.683838] [061/165] (853s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[163.320332] Starting subtest: addfb25-y-tiled-legacy
[163.322405] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s)
[163.497518] [062/165] (853s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[164.302609] Starting subtest: addfb25-y-tiled-small-legacy
[164.310727] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[164.542443] [063/165] (852s left) kms_addfb_basic (bad-pitch-0)
[165.010145] Starting subtest: bad-pitch-0
[165.014310] Subtest bad-pitch-0: SUCCESS (0.000s)
[165.850318] [064/165] (850s left) kms_addfb_basic (bad-pitch-1024)
[166.202974] Starting subtest: bad-pitch-1024
[166.210434] Subtest bad-pitch-1024: SUCCESS (0.000s)
[166.895580] [065/165] (849s left) kms_addfb_basic (bad-pitch-128)
[167.132930] Starting subtest: bad-pitch-128
[167.136218] Subtest bad-pitch-128: SUCCESS (0.000s)
[167.930913] [066/165] (848s left) kms_addfb_basic (bad-pitch-256)
[168.159466] Starting subtest: bad-pitch-256
[168.164149] Subtest bad-pitch-256: SUCCESS (0.000s)
[168.872418] [067/165] (848s left) kms_addfb_basic (bad-pitch-32)
[169.150061] Starting subtest: bad-pitch-32
[169.155051] Subtest bad-pitch-32: SUCCESS (0.000s)
[169.851130] [068/165] (847s left) kms_addfb_basic (bad-pitch-63)
[170.094401] Starting subtest: bad-pitch-63
[170.097310] Subtest bad-pitch-63: SUCCESS (0.000s)
[170.776380] [069/165] (846s left) kms_addfb_basic (bad-pitch-65536)
[171.006547] Starting subtest: bad-pitch-65536
[171.008568] Subtest bad-pitch-65536: SUCCESS (0.002s)
[171.620811] [070/165] (845s left) kms_addfb_basic (bad-pitch-999)
[171.852383] Starting subtest: bad-pitch-999
[171.856040] Subtest bad-pitch-999: SUCCESS (0.000s)
[172.448749] [071/165] (844s left) kms_addfb_basic (basic)
[172.673192] Starting subtest: basic
[172.677604] Subtest basic: SUCCESS (0.000s)
[173.250699] [072/165] (844s left) kms_addfb_basic (basic-x-tiled-legacy)
[173.481292] Starting subtest: basic-x-tiled-legacy
[173.483996] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[174.050891] [073/165] (843s left) kms_addfb_basic (basic-y-tiled-legacy)
[174.285874] Starting subtest: basic-y-tiled-legacy
[174.288768] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[174.849208] [074/165] (842s left) kms_addfb_basic (bo-too-small)
[175.501656] Starting subtest: bo-too-small
[175.505708] Subtest bo-too-small: SUCCESS (0.001s)
[175.684375] [075/165] (841s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[176.330506] Starting subtest: bo-too-small-due-to-tiling
[176.346109] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[176.514455] [076/165] (840s left) kms_addfb_basic (clobberred-modifier)
[176.743120] Starting subtest: clobberred-modifier
[176.744822] Subtest clobberred-modifier: SUCCESS (0.000s)
[177.317328] [077/165] (840s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[177.545696] Starting subtest: framebuffer-vs-set-tiling
[177.548583] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.113329] [078/165] (839s left) kms_addfb_basic (invalid-get-prop)
[178.350445] Starting subtest: invalid-get-prop
[178.353232] Subtest invalid-get-prop: SUCCESS (0.000s)
[178.914842] [079/165] (838s left) kms_addfb_basic (invalid-get-prop-any)
[179.141188] Starting subtest: invalid-get-prop-any
[179.144050] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[179.716642] [080/165] (837s left) kms_addfb_basic (invalid-set-prop)
[179.946277] Starting subtest: invalid-set-prop
[179.947801] Subtest invalid-set-prop: SUCCESS (0.000s)
[180.519628] [081/165] (837s left) kms_addfb_basic (invalid-set-prop-any)
[180.753420] Starting subtest: invalid-set-prop-any
[180.755181] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[181.348615] [082/165] (836s left) kms_addfb_basic (no-handle)
[181.576928] Starting subtest: no-handle
[181.579366] Subtest no-handle: SUCCESS (0.000s)
[182.149519] [083/165] (835s left) kms_addfb_basic (size-max)
[182.798327] Starting subtest: size-max
[182.802080] Subtest size-max: SUCCESS (0.000s)
[182.955756] [084/165] (834s left) kms_addfb_basic (small-bo)
[183.590663] Starting subtest: small-bo
[183.592713] Subtest small-bo: SUCCESS (0.000s)
[183.751293] [085/165] (834s left) kms_addfb_basic (tile-pitch-mismatch)
[183.991380] Starting subtest: tile-pitch-mismatch
[183.993111] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[184.583562] [086/165] (833s left) kms_addfb_basic (too-high)
[185.240685] Starting subtest: too-high
[185.253628] Subtest too-high: SUCCESS (0.009s)
[185.416799] [087/165] (832s left) kms_addfb_basic (too-wide)
[186.043900] Starting subtest: too-wide
[186.047206] Subtest too-wide: SUCCESS (0.000s)
[186.224638] [088/165] (831s left) kms_addfb_basic (unused-handle)
[186.455176] Starting subtest: unused-handle
[186.459601] Subtest unused-handle: SUCCESS (0.000s)
[187.049277] [089/165] (831s left) kms_addfb_basic (unused-modifier)
[187.278939] Starting subtest: unused-modifier
[187.280652] Subtest unused-modifier: SUCCESS (0.000s)
[187.856665] [090/165] (830s left) kms_addfb_basic (unused-offsets)
[188.088729] Starting subtest: unused-offsets
[188.091470] Subtest unused-offsets: SUCCESS (0.002s)
[188.683731] [091/165] (829s left) kms_addfb_basic (unused-pitches)
[188.908532] Starting subtest: unused-pitches
[188.911801] Subtest unused-pitches: SUCCESS (0.000s)
[189.481671] [092/165] (828s left) kms_busy (basic)
[190.152096] Starting subtest: basic
[190.154358] Starting dynamic subtest: flip
[191.719398] Dynamic subtest flip: SUCCESS (1.564s)
[191.750095] Starting dynamic subtest: modeset
[194.567174] Dynamic subtest modeset: SUCCESS (2.839s)
[194.572140] Subtest basic: SUCCESS (4.409s)
[195.290226] [093/165] (823s left) kms_prop_blob (basic)
[195.531540] Starting subtest: basic
[195.535288] Subtest basic: SUCCESS (0.000s)
[195.682880] [094/165] (822s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[196.360154] Starting subtest: basic-busy-flip-before-cursor-atomic
[198.602729] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (2.244s)
[199.171697] [095/165] (819s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[199.846607] Starting subtest: basic-busy-flip-before-cursor-legacy
[202.116105] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (2.272s)
[202.808885] [096/165] (815s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[203.515378] Starting subtest: basic-flip-after-cursor-atomic
[205.690206] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.170s)
[206.297748] [097/165] (812s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[206.945485] Starting subtest: basic-flip-after-cursor-legacy
[209.110477] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.165s)
[209.723486] [098/165] (808s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[210.378922] Starting subtest: basic-flip-after-cursor-varying-size
[212.605275] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.226s)
[213.219561] [099/165] (805s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[213.883087] Starting subtest: basic-flip-before-cursor-atomic
[216.100147] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.220s)
[216.726421] [100/165] (802s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[217.393598] Starting subtest: basic-flip-before-cursor-legacy
[219.607318] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.218s)
[220.224766] [101/165] (798s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[220.897211] Starting subtest: basic-flip-before-cursor-varying-size
[223.179690] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.283s)
[223.811855] [102/165] (795s left) kms_dsc (dsc-basic)
[224.470120] Subtest dsc-basic: SKIP (0.000s)
[224.556882] [103/165] (794s left) kms_flip (basic-flip-vs-dpms)
[225.019398] Starting subtest: basic-flip-vs-dpms
[225.043995] Starting dynamic subtest: C-HDMI-A2
[228.433130] Dynamic subtest C-HDMI-A2: SUCCESS (3.379s)
[228.438100] Subtest basic-flip-vs-dpms: SUCCESS (3.403s)
[229.007949] [104/165] (790s left) kms_flip (basic-flip-vs-modeset)
[229.468636] Starting subtest: basic-flip-vs-modeset
[229.489310] Starting dynamic subtest: C-HDMI-A2
[232.669902] Dynamic subtest C-HDMI-A2: SUCCESS (3.168s)
[232.678094] Subtest basic-flip-vs-modeset: SUCCESS (3.196s)
[233.363912] [105/165] (785s left) kms_flip (basic-flip-vs-wf_vblank)
[233.818646] Starting subtest: basic-flip-vs-wf_vblank
[233.841720] Starting dynamic subtest: C-HDMI-A2
[237.607457] Dynamic subtest C-HDMI-A2: SUCCESS (3.763s)
[237.612954] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.787s)
[237.850823] [106/165] (781s left) kms_flip (basic-plain-flip)
[238.314969] Starting subtest: basic-plain-flip
[238.327390] Starting dynamic subtest: C-HDMI-A2
[241.339057] Dynamic subtest C-HDMI-A2: SUCCESS (3.002s)
[241.343112] Subtest basic-plain-flip: SUCCESS (3.026s)
[241.568595] [107/165] (777s left) kms_force_connector_basic (force-connector-state)
[241.920073] Starting subtest: force-connector-state
[242.812638] Subtest force-connector-state: SUCCESS (0.894s)
[244.199678] [108/165] (775s left) kms_force_connector_basic (force-edid)
[244.536113] Starting subtest: force-edid
[244.621091] Subtest force-edid: SUCCESS (0.078s)
[245.464225] [109/165] (773s left) kms_force_connector_basic (force-load-detect)
[245.844676] Starting subtest: force-load-detect
[245.849068] Subtest force-load-detect: SKIP (0.000s)
[246.430411] [110/165] (772s left) kms_force_connector_basic (prune-stale-modes)
[246.807588] Starting subtest: prune-stale-modes
[246.913952] Subtest prune-stale-modes: SUCCESS (0.099s)
[247.731523] [111/165] (771s left) kms_frontbuffer_tracking (basic)
[248.477170] Starting subtest: basic
[253.773927] Subtest basic: FAIL (4.972s)
[253.899178] [112/165] (765s left) kms_hdmi_inject (inject-audio)
[254.279602] Starting subtest: inject-audio
[254.744439] Subtest inject-audio: FAIL (0.434s)
[255.788760] [113/165] (763s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[256.541137] Starting subtest: compare-crc-sanitycheck-xr24
[256.544657] Starting dynamic subtest: pipe-C-HDMI-A-2
[257.614909] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.058s)
[257.618256] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.074s)
[258.288227] [114/165] (761s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[258.981118] Starting subtest: compare-crc-sanitycheck-nv12
[258.996657] Starting dynamic subtest: pipe-C-HDMI-A-2
[259.000866] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[259.005996] Subtest compare-crc-sanitycheck-nv12: SKIP (0.008s)
[259.157191] [115/165] (760s left) kms_pipe_crc_basic (hang-read-crc)
[259.868611] Starting subtest: hang-read-crc
[259.872218] Starting dynamic subtest: pipe-C-HDMI-A-2
[262.568401] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.698s)
[262.572984] Subtest hang-read-crc: SUCCESS (2.708s)
[263.162425] [116/165] (756s left) kms_pipe_crc_basic (nonblocking-crc)
[263.864635] Starting subtest: nonblocking-crc
[263.867996] Starting dynamic subtest: pipe-C-HDMI-A-2
[265.339233] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.469s)
[265.342364] Subtest nonblocking-crc: SUCCESS (1.482s)
[265.896867] [117/165] (753s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[266.576411] Starting subtest: nonblocking-crc-frame-sequence
[266.590094] Starting dynamic subtest: pipe-C-HDMI-A-2
[267.918229] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.332s)
[267.919841] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.342s)
[268.482270] [118/165] (751s left) kms_pipe_crc_basic (read-crc)
[269.183178] Starting subtest: read-crc
[269.187720] Starting dynamic subtest: pipe-C-HDMI-A-2
[270.428407] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.235s)
[270.431584] Subtest read-crc: SUCCESS (1.249s)
[271.037884] [119/165] (748s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[271.733938] Starting subtest: read-crc-frame-sequence
[271.744212] Starting dynamic subtest: pipe-C-HDMI-A-2
[273.023748] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.276s)
[273.029354] Subtest read-crc-frame-sequence: SUCCESS (1.286s)
[273.517589] [120/165] (746s left) kms_pm_backlight (basic-brightness)
[274.209191] Subtest basic-brightness: SKIP (0.000s)
[274.314506] [121/165] (745s left) kms_pm_rpm (basic-pci-d3-state)
[276.818274] Starting subtest: basic-pci-d3-state
[277.168778] Subtest basic-pci-d3-state: SUCCESS (0.343s)
[277.567173] [122/165] (742s left) kms_pm_rpm (basic-rte)
[277.790121] Starting subtest: basic-rte
[280.410360] Subtest basic-rte: SUCCESS (2.618s)
[281.618952] [123/165] (738s left) kms_psr (primary_page_flip)
[281.849875] Subtest primary_page_flip: SKIP (0.000s)
[281.941293] [124/165] (738s left) kms_psr (cursor_plane_move)
[282.165384] Subtest cursor_plane_move: SKIP (0.000s)
[282.278241] [125/165] (737s left) kms_psr (sprite_plane_onoff)
[282.500237] Subtest sprite_plane_onoff: SKIP (0.000s)
[282.608789] [126/165] (737s left) kms_psr (primary_mmap_gtt)
[282.839696] Subtest primary_mmap_gtt: SKIP (0.000s)
[282.943340] [127/165] (737s left) kms_setmode (basic-clone-single-crtc)
[283.179766] Starting subtest: basic-clone-single-crtc
[283.186588] Subtest basic-clone-single-crtc: SKIP (0.001s)
[283.355149] [128/165] (737s left) i915_pm_rps (basic-api)
[283.598831] Starting subtest: basic-api
[283.617514] Subtest basic-api: SUCCESS (0.014s)
[283.782414] [129/165] (736s left) prime_self_import (basic-llseek-bad)
[284.007545] Starting subtest: basic-llseek-bad
[284.019495] Subtest basic-llseek-bad: SUCCESS (0.013s)
[284.180375] [130/165] (736s left) prime_self_import (basic-llseek-size)
[284.401415] Starting subtest: basic-llseek-size
[284.415028] Subtest basic-llseek-size: SUCCESS (0.015s)
[284.581309] [131/165] (736s left) prime_self_import (basic-with_fd_dup)
[284.797687] Starting subtest: basic-with_fd_dup
[284.811560] Subtest basic-with_fd_dup: SUCCESS (0.011s)
[284.979618] [132/165] (735s left) prime_self_import (basic-with_one_bo)
[285.194845] Starting subtest: basic-with_one_bo
[285.212696] Subtest basic-with_one_bo: SUCCESS (0.019s)
[285.374697] [133/165] (735s left) prime_self_import (basic-with_one_bo_two_files)
[285.594761] Starting subtest: basic-with_one_bo_two_files
[285.607260] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[285.786432] [134/165] (734s left) prime_self_import (basic-with_two_bos)
[286.005480] Starting subtest: basic-with_two_bos
[286.020239] Subtest basic-with_two_bos: SUCCESS (0.015s)
[286.184878] [135/165] (734s left) prime_vgem (basic-fence-flip)
[286.467643] Starting subtest: basic-fence-flip
[287.486902] Subtest basic-fence-flip: SKIP (1.015s)
[287.755642] [136/165] (733s left) prime_vgem (basic-fence-mmap)
[288.040303] Starting subtest: basic-fence-mmap
[288.143938] Subtest basic-fence-mmap: SUCCESS (0.107s)
[288.324657] [137/165] (732s left) prime_vgem (basic-fence-read)
[288.601142] Starting subtest: basic-fence-read
[288.792263] Subtest basic-fence-read: SUCCESS (0.189s)
[288.953971] [138/165] (732s left) prime_vgem (basic-gtt)
[289.235420] Starting subtest: basic-gtt
[289.282383] Subtest basic-gtt: SUCCESS (0.043s)
[289.449861] [139/165] (731s left) prime_vgem (basic-read)
[289.706758] Starting subtest: basic-read
[289.780508] Subtest basic-read: SUCCESS (0.076s)
[289.951543] [140/165] (731s left) prime_vgem (basic-write)
[290.199395] Starting subtest: basic-write
[290.297615] Subtest basic-write: SUCCESS (0.093s)
[290.480563] [141/165] (730s left) vgem_basic (setversion)
[290.748599] Starting subtest: setversion
[290.751618] Subtest setversion: SUCCESS (0.001s)
[290.881895] [142/165] (730s left) vgem_basic (create)
[291.117977] Starting subtest: create
[291.122170] Subtest create: SUCCESS (0.001s)
[291.254437] [143/165] (730s left) vgem_basic (debugfs)
[291.514249] Starting subtest: debugfs
[291.517898] Subtest debugfs: SUCCESS (0.002s)
[291.650663] [144/165] (729s left) vgem_basic (dmabuf-export)
[291.883070] Starting subtest: dmabuf-export
[291.888819] Subtest dmabuf-export: SUCCESS (0.008s)
[292.053621] [145/165] (729s left) vgem_basic (dmabuf-fence)
[292.318974] Starting subtest: dmabuf-fence
[292.323429] Subtest dmabuf-fence: SUCCESS (0.003s)
[292.450709] [146/165] (729s left) vgem_basic (dmabuf-fence-before)
[292.715580] Starting subtest: dmabuf-fence-before
[292.717657] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[292.851459] [147/165] (728s left) vgem_basic (dmabuf-mmap)
[293.084056] Starting subtest: dmabuf-mmap
[293.122143] Subtest dmabuf-mmap: SUCCESS (0.041s)
[293.255715] [148/165] (728s left) vgem_basic (mmap)
[293.514759] Starting subtest: mmap
[293.547428] Subtest mmap: SUCCESS (0.031s)
[293.684413] [149/165] (727s left) vgem_basic (second-client)
[293.912730] Starting subtest: second-client
[293.977440] Subtest second-client: SUCCESS (0.067s)
[294.119388] [150/165] (727s left) vgem_basic (sysfs)
[294.380248] Starting subtest: sysfs
[294.388204] Subtest sysfs: SUCCESS (0.004s)
[294.517387] [151/165] (727s left) core_hotunplug (unbind-rebind)
[294.846067] Starting subtest: unbind-rebind
[300.026092] Subtest unbind-rebind: SUCCESS (5.175s)
[300.095910] [152/165] (721s left) vgem_basic (unload)
[300.335448] Starting subtest: unload
[329.551792] Subtest unload: SUCCESS (29.215s)
[329.838448] [153/165] (692s left) i915_module_load (reload)
[330.072408] Starting subtest: reload
[335.083330] Subtest reload: SUCCESS (5.008s)
[335.223348] [154/165] (686s left) gem_lmem_swapping (basic)
[335.817154] Subtest basic: SKIP (0.000s)
[335.974938] [155/165] (686s left) gem_lmem_swapping (parallel-random-engines)
[336.252365] Subtest parallel-random-engines: SKIP (0.000s)
[336.343229] [156/165] (685s left) gem_lmem_swapping (random-engines)
[336.586674] Subtest random-engines: SKIP (0.000s)
[336.678785] [157/165] (685s left) gem_lmem_swapping (verify-random)
[336.919284] Subtest verify-random: SKIP (0.000s)
[337.008148] [158/165] (685s left) i915_pm_rpm (module-reload)
[339.936113] Starting subtest: module-reload
[352.323028] Subtest module-reload: SUCCESS (12.394s)
[352.376649] [159/165] (670s left) i915_selftest (live)
[352.635617] Starting subtest: live
[352.637348] Starting dynamic subtest: sanitycheck
[354.550298] Dynamic subtest sanitycheck: SUCCESS (1.916s)
[354.569650] Starting dynamic subtest: uncore
[356.352123] Dynamic subtest uncore: SUCCESS (1.799s)
[356.377850] Starting dynamic subtest: workarounds
[358.369726] Dynamic subtest workarounds: SUCCESS (2.009s)
[358.388716] Starting dynamic subtest: gt_engines
[360.633260] Dynamic subtest gt_engines: SUCCESS (2.259s)
[360.651767] Starting dynamic subtest: gt_timelines
[388.756737] Dynamic subtest gt_timelines: SUCCESS (28.124s)
[388.786347] Starting dynamic subtest: gt_contexts
[390.769224] Dynamic subtest gt_contexts: SUCCESS (2.000s)
[390.787703] Starting dynamic subtest: gt_lrc
[395.858069] Dynamic subtest gt_lrc: SUCCESS (5.085s)
[395.877788] Starting dynamic subtest: gt_mocs
[397.653088] Dynamic subtest gt_mocs: SUCCESS (1.789s)
[397.704253] Starting dynamic subtest: gt_pm
[400.457578] Dynamic subtest gt_pm: SUCCESS (2.795s)
[400.477676] Starting dynamic subtest: gt_heartbeat
[402.359270] Dynamic subtest gt_heartbeat: SUCCESS (1.900s)
[402.385567] Starting dynamic subtest: gt_tlb
[404.592177] Dynamic subtest gt_tlb: SUCCESS (2.223s)
[404.615775] Starting dynamic subtest: requests
[412.892146] Dynamic subtest requests: SUCCESS (8.292s)
[412.911300] Starting dynamic subtest: migrate
[418.122369] Dynamic subtest migrate: SUCCESS (5.231s)
[418.151210] Starting dynamic subtest: active
[419.992122] Dynamic subtest active: SUCCESS (1.855s)
[420.010760] Starting dynamic subtest: objects
[423.781747] Dynamic subtest objects: SUCCESS (3.789s)
[423.801255] Starting dynamic subtest: mman
[434.174942] Dynamic subtest mman: SUCCESS (10.387s)
[434.193542] Starting dynamic subtest: dmabuf
[436.039144] Dynamic subtest dmabuf: SUCCESS (1.855s)
[436.085390] Starting dynamic subtest: vma
[437.789088] Dynamic subtest vma: SUCCESS (1.746s)
[437.814898] Starting dynamic subtest: coherency
[443.324616] Dynamic subtest coherency: SUCCESS (5.531s)
[443.343335] Starting dynamic subtest: gtt
[452.667378] Dynamic subtest gtt: SUCCESS (9.341s)
[452.695630] Starting dynamic subtest: gem
[455.396344] Dynamic subtest gem: SUCCESS (2.721s)
[455.417871] Starting dynamic subtest: evict
[463.371193] Dynamic subtest evict: SUCCESS (7.970s)
[463.389787] Starting dynamic subtest: hugepages
[465.630874] Dynamic subtest hugepages: SUCCESS (2.253s)
[465.649517] Starting dynamic subtest: gem_contexts
[490.070176] Dynamic subtest gem_contexts: SUCCESS (24.438s)
[490.089529] Starting dynamic subtest: client
[491.977517] Dynamic subtest client: SUCCESS (1.904s)
[491.998186] Starting dynamic subtest: gem_migrate
[493.716277] Dynamic subtest gem_migrate: SUCCESS (1.734s)
[493.737276] Starting dynamic subtest: reset
[503.516232] Dynamic subtest reset: SUCCESS (9.795s)
[503.535865] Starting dynamic subtest: memory_region
[505.360655] Dynamic subtest memory_region: SUCCESS (1.841s)
[505.396370] Starting dynamic subtest: hangcheck
[530.531333] Dynamic subtest hangcheck: SUCCESS (25.162s)
[530.551899] Starting dynamic subtest: execlists
[542.111120] Dynamic subtest execlists: SUCCESS (11.575s)
[542.132697] Starting dynamic subtest: ring_submission
[543.932645] Dynamic subtest ring_submission: SUCCESS (1.820s)
[543.957781] Starting dynamic subtest: perf
[546.118479] Dynamic subtest perf: SUCCESS (2.179s)
[546.137856] Starting dynamic subtest: slpc
[547.946105] Dynamic subtest slpc: SUCCESS (1.823s)
[547.965178] Starting dynamic subtest: guc
[549.756642] Dynamic subtest guc: SUCCESS (1.808s)
[549.782830] Starting dynamic subtest: guc_multi_lrc
[551.639094] Dynamic subtest guc_multi_lrc: SUCCESS (1.876s)
[551.657960] Starting dynamic subtest: guc_hang
[553.519124] Dynamic subtest guc_hang: SUCCESS (1.873s)
[553.539109] Starting dynamic subtest: late_gt_pm
[555.430138] Dynamic subtest late_gt_pm: SUCCESS (1.906s)
[555.432532] Subtest live: SUCCESS (202.798s)
[555.493191] [160/165] (466s left) dmabuf (all-tests)
[555.732683] Starting subtest: all-tests
[555.737784] Starting dynamic subtest: sanitycheck
[555.801963] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[555.837139] Starting dynamic subtest: dma_fence
[555.998580] Dynamic subtest dma_fence: SUCCESS (0.191s)
[556.048215] Starting dynamic subtest: dma_fence_chain
[586.696275] Dynamic subtest dma_fence_chain: SUCCESS (30.689s)
[586.737240] Starting dynamic subtest: dma_fence_unwrap
[586.782926] Dynamic subtest dma_fence_unwrap: SUCCESS (0.080s)
[586.829847] Starting dynamic subtest: dma_resv
[586.862317] Dynamic subtest dma_resv: SUCCESS (0.067s)
[586.865696] Subtest all-tests: SUCCESS (31.135s)
[586.925601] [161/165] (435s left) i915_suspend (basic-s2idle-without-i915)
[587.150637] Starting subtest: basic-s2idle-without-i915
[609.350831] Subtest basic-s2idle-without-i915: SUCCESS (7.684s)
[612.202506] [162/165] (426s left) i915_suspend (basic-s3-without-i915)
[612.447607] Starting subtest: basic-s3-without-i915
[633.082501] Subtest basic-s3-without-i915: SUCCESS (5.737s)
[634.909708] [163/165] (420s left) gem_exec_suspend (basic-s0)
[635.220621] Starting subtest: basic-S0
[635.222857] Starting dynamic subtest: smem
[658.016019] Dynamic subtest smem: SUCCESS (7.494s)
[658.018306] Subtest basic-S0: SUCCESS (7.498s)
[660.245125] [164/165] (412s left) gem_exec_suspend (basic-s3)
[660.521623] Starting subtest: basic-S3
[660.525048] Starting dynamic subtest: smem
[683.946607] Dynamic subtest smem: SUCCESS (8.305s)
[683.948907] Subtest basic-S3: SUCCESS (8.311s)
[685.198566] [165/165] (403s left) kms_pipe_crc_basic (suspend-read-crc)
[685.930377] Starting subtest: suspend-read-crc
[685.936311] Starting dynamic subtest: pipe-C-HDMI-A-2
[707.216252] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.611s)
[707.218515] Subtest suspend-read-crc: SUCCESS (5.627s)
[709.640076] Closing watchdogs
Done.