[34.580352] Initializing watchdogs
[34.580525]   /dev/watchdog0
[34.606282] [001/164] (960s left) i915_module_load (load)
[34.752057] Starting subtest: load
[36.184819] Subtest load: SUCCESS (1.423s)
[36.325175] [002/164] (958s left) core_auth (basic-auth)
[36.484400] Starting subtest: basic-auth
[36.503579] Subtest basic-auth: SUCCESS (0.001s)
[36.580988] [003/164] (958s left) debugfs_test (read_all_entries)
[36.730984] Starting subtest: read_all_entries
[36.752849] Subtest read_all_entries: SUCCESS (0.044s)
[36.857520] [004/164] (958s left) debugfs_test (basic-hwmon)
[37.001509] Starting subtest: basic-hwmon
[37.041651] Subtest basic-hwmon: SKIP (0.000s)
[37.113820] [005/164] (958s left) fbdev (eof)
[37.249198] Starting subtest: eof
[37.268628] Subtest eof: SUCCESS (0.001s)
[37.364274] [006/164] (958s left) fbdev (info)
[37.494904] Starting subtest: info
[37.514141] Subtest info: SUCCESS (0.000s)
[37.618626] [007/164] (957s left) fbdev (nullptr)
[37.743338] Starting subtest: nullptr
[37.765700] Subtest nullptr: SUCCESS (0.000s)
[37.859289] [008/164] (957s left) fbdev (read)
[37.991039] Starting subtest: read
[38.113482] Subtest read: SUCCESS (0.132s)
[38.222284] [009/164] (957s left) fbdev (write)
[38.353331] Starting subtest: write
[38.405686] Subtest write: SUCCESS (0.068s)
[38.533819] [010/164] (957s left) gem_basic (bad-close)
[38.714082] Starting subtest: bad-close
[38.772296] Subtest bad-close: SUCCESS (0.000s)
[38.869550] [011/164] (956s left) gem_basic (create-close)
[39.033294] Starting subtest: create-close
[39.083529] Subtest create-close: SUCCESS (0.000s)
[39.180806] [012/164] (956s left) gem_basic (create-fd-close)
[39.352513] Starting subtest: create-fd-close
[39.409689] Subtest create-fd-close: SUCCESS (0.000s)
[39.499929] [013/164] (956s left) gem_busy (busy@all-engines)
[39.692188] Starting subtest: busy
[39.715064] Starting dynamic subtest: all-engines
[39.738674] Dynamic subtest all-engines: SUCCESS (0.024s)
[39.764664] Subtest busy: SUCCESS (0.024s)
[40.031428] [014/164] (956s left) gem_close_race (basic-process)
[40.211896] Starting subtest: basic-process
[40.236646] Subtest basic-process: SUCCESS (0.041s)
[40.398968] [015/164] (955s left) gem_close_race (basic-threads)
[40.541943] Starting subtest: basic-threads
[41.725319] Subtest basic-threads: SUCCESS (1.205s)
[41.921820] [016/164] (954s left) gem_ctx_create (basic)
[42.075069] Starting subtest: basic
[42.093897] Subtest basic: SUCCESS (0.000s)
[42.233448] [017/164] (954s left) gem_ctx_create (basic-files)
[42.357535] Starting subtest: basic-files
[44.358768] Subtest basic-files: SUCCESS (2.015s)
[44.606817] [018/164] (951s left) gem_ctx_exec (basic)
[44.766705] Starting subtest: basic
[44.786060] Subtest basic: SUCCESS (0.002s)
[44.863401] [019/164] (951s left) gem_exec_basic (basic)
[45.015979] Starting subtest: basic
[45.037875] Starting dynamic subtest: rcs0-smem
[45.059596] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[45.087599] Starting dynamic subtest: bcs0-smem
[45.108569] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[45.136610] Starting dynamic subtest: vcs0-smem
[45.156075] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[45.175246] Subtest basic: SUCCESS (0.001s)
[45.251995] [020/164] (951s left) gem_exec_create (basic)
[45.407301] Starting subtest: basic
[45.428362] Starting dynamic subtest: smem
[47.449748] Dynamic subtest smem: SUCCESS (2.048s)
[47.469278] Subtest basic: SUCCESS (2.049s)
[47.624362] [021/164] (948s left) gem_exec_fence (basic-busy)
[47.876974] Starting subtest: basic-busy
[47.896615] Starting dynamic subtest: rcs0
[47.935784] Dynamic subtest rcs0: SUCCESS (0.021s)
[47.961301] Starting dynamic subtest: bcs0
[48.004941] Dynamic subtest bcs0: SUCCESS (0.025s)
[48.029929] Starting dynamic subtest: vcs0
[48.073681] Dynamic subtest vcs0: SUCCESS (0.031s)
[48.094295] Subtest basic-busy: SUCCESS (0.078s)
[48.527994] [022/164] (948s left) gem_exec_fence (basic-wait)
[48.769599] Starting subtest: basic-wait
[48.791454] Starting dynamic subtest: rcs0
[48.810841] Dynamic subtest rcs0: SUCCESS (0.030s)
[48.838807] Starting dynamic subtest: bcs0
[48.858346] Dynamic subtest bcs0: SUCCESS (0.030s)
[48.886131] Starting dynamic subtest: vcs0
[48.908198] Dynamic subtest vcs0: SUCCESS (0.024s)
[48.930101] Subtest basic-wait: SUCCESS (0.084s)
[49.312176] [023/164] (947s left) gem_exec_fence (basic-await)
[49.544566] Starting subtest: basic-await
[49.563570] Starting dynamic subtest: rcs0
[49.613472] Dynamic subtest rcs0: SUCCESS (0.068s)
[49.639702] Starting dynamic subtest: bcs0
[49.681695] Dynamic subtest bcs0: SUCCESS (0.067s)
[49.707185] Starting dynamic subtest: vcs0
[49.754939] Dynamic subtest vcs0: SUCCESS (0.067s)
[49.773948] Subtest basic-await: SUCCESS (0.203s)
[50.213959] [024/164] (946s left) gem_exec_fence (nb-await)
[50.451559] Starting subtest: nb-await
[50.472588] Starting dynamic subtest: rcs0
[50.511229] Dynamic subtest rcs0: SUCCESS (0.053s)
[50.534360] Starting dynamic subtest: bcs0
[50.572975] Dynamic subtest bcs0: SUCCESS (0.052s)
[50.598810] Starting dynamic subtest: vcs0
[50.620683] Dynamic subtest vcs0: SUCCESS (0.052s)
[50.641942] Subtest nb-await: SUCCESS (0.157s)
[51.060180] [025/164] (945s left) gem_exec_gttfill (basic)
[51.201051] Starting subtest: basic
[53.232676] Subtest basic: SUCCESS (2.054s)
[53.423097] [026/164] (943s left) gem_exec_parallel (engines)
[53.673274] Starting subtest: engines
[53.691911] Starting dynamic subtest: basic
[55.010944] Dynamic subtest basic: SUCCESS (1.354s)
[55.038603] Starting dynamic subtest: contexts
[56.518725] Dynamic subtest contexts: SUCCESS (1.518s)
[56.542536] Starting dynamic subtest: fds
[58.260594] Dynamic subtest fds: SUCCESS (1.741s)
[58.287474] Starting dynamic subtest: userptr
[59.711028] Dynamic subtest userptr: SUCCESS (1.439s)
[59.730410] Subtest engines: SUCCESS (6.053s)
[59.914669] [027/164] (937s left) gem_exec_store (basic)
[60.132411] Starting subtest: basic
[60.151576] Subtest basic: SUCCESS (0.034s)
[60.275949] [028/164] (936s left) gem_flink_basic (bad-flink)
[60.425218] Starting subtest: bad-flink
[60.447361] Subtest bad-flink: SUCCESS (0.000s)
[60.526921] [029/164] (936s left) gem_flink_basic (bad-open)
[60.674828] Starting subtest: bad-open
[60.696112] Subtest bad-open: SUCCESS (0.000s)
[60.771273] [030/164] (936s left) gem_flink_basic (basic)
[60.917442] Starting subtest: basic
[60.937046] Subtest basic: SUCCESS (0.000s)
[61.009639] [031/164] (936s left) gem_flink_basic (double-flink)
[61.177960] Starting subtest: double-flink
[61.201259] Subtest double-flink: SUCCESS (0.000s)
[61.282227] [032/164] (935s left) gem_flink_basic (flink-lifetime)
[61.438431] Starting subtest: flink-lifetime
[61.462437] Subtest flink-lifetime: SUCCESS (0.001s)
[61.546370] [033/164] (935s left) gem_huc_copy (huc-copy)
[61.741943] Subtest huc-copy: SKIP (0.000s)
[61.828902] [034/164] (935s left) gem_linear_blits (basic)
[62.059209] Starting subtest: basic
[62.089293] Subtest basic: SUCCESS (0.005s)
[62.231421] [035/164] (935s left) gem_mmap (basic)
[62.508355] Starting subtest: basic
[62.606858] Subtest basic: SUCCESS (0.000s)
[62.686813] [036/164] (934s left) gem_mmap_gtt (basic)
[62.837512] Starting subtest: basic
[62.860169] Subtest basic: SUCCESS (0.001s)
[62.939160] [037/164] (934s left) gem_render_linear_blits (basic)
[63.090112] Starting subtest: basic
[63.188953] Subtest basic: SUCCESS (0.022s)
[63.269514] [038/164] (934s left) gem_render_tiled_blits (basic)
[63.422168] Starting subtest: basic
[63.545356] Subtest basic: SUCCESS (0.022s)
[63.625512] [039/164] (934s left) gem_ringfill (basic-all)
[63.864347] Starting subtest: basic-all
[64.944287] Subtest basic-all: SUCCESS (1.108s)
[65.063874] [040/164] (932s left) gem_softpin (allocator-basic)
[65.234722] Subtest allocator-basic: SKIP (0.000s)
[65.331933] [041/164] (932s left) gem_softpin (allocator-basic-reserve)
[65.485554] Subtest allocator-basic-reserve: SKIP (0.000s)
[65.577970] [042/164] (932s left) gem_softpin (safe-alignment)
[65.764864] Starting subtest: safe-alignment
[65.787029] Subtest safe-alignment: SUCCESS (0.006s)
[65.867965] [043/164] (932s left) gem_sync (basic-all)
[66.063841] Starting subtest: basic-all
[68.078764] Subtest basic-all: SUCCESS (2.081s)
[68.266488] [044/164] (929s left) gem_sync (basic-each)
[68.452666] Starting subtest: basic-each
[70.546370] Subtest basic-each: SUCCESS (2.147s)
[70.721619] [045/164] (927s left) gem_tiled_blits (basic)
[70.918494] Starting subtest: basic
[70.941166] Subtest basic: SUCCESS (0.014s)
[71.088506] [046/164] (927s left) gem_tiled_fence_blits (basic)
[71.376518] Starting subtest: basic
[71.397034] Subtest basic: SUCCESS (0.008s)
[71.528340] [047/164] (926s left) gem_tiled_pread_basic
[71.932389] [048/164] (926s left) gem_wait (busy@all-engines)
[72.103375] Starting subtest: busy
[72.123019] Starting dynamic subtest: all-engines
[72.597443] Dynamic subtest all-engines: SUCCESS (0.514s)
[72.618288] Subtest busy: SUCCESS (0.514s)
[72.810361] [049/164] (925s left) gem_wait (wait@all-engines)
[72.961468] Starting subtest: wait
[72.981224] Starting dynamic subtest: all-engines
[73.957989] Dynamic subtest all-engines: SUCCESS (1.017s)
[73.978883] Subtest wait: SUCCESS (1.018s)
[74.166926] [050/164] (924s left) i915_getparams_basic (basic-eu-total)
[74.315768] Starting subtest: basic-eu-total
[74.355504] Subtest basic-eu-total: SUCCESS (0.000s)
[74.429661] [051/164] (924s left) i915_getparams_basic (basic-subslice-total)
[74.578123] Starting subtest: basic-subslice-total
[74.617850] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.696887] [052/164] (924s left) i915_hangman (error-state-basic)
[74.836253] Starting subtest: error-state-basic
[74.864094] Subtest error-state-basic: SUCCESS (0.007s)
[74.938634] [053/164] (923s left) i915_pciid
[75.182689] [054/164] (923s left) kms_addfb_basic (addfb25-4-tiled)
[75.382335] Starting subtest: addfb25-4-tiled
[75.403164] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[75.484460] [055/164] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[75.627848] Starting subtest: addfb25-bad-modifier
[75.649447] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[75.726457] [056/164] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.878775] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.902384] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.977156] [057/164] (923s left) kms_addfb_basic (addfb25-modifier-no-flag)
[76.127748] Starting subtest: addfb25-modifier-no-flag
[76.146926] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[76.224249] [058/164] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.368713] Starting subtest: addfb25-x-tiled-legacy
[76.389246] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.470077] [059/164] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.597947] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.622712] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.702656] [060/164] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[76.848200] Starting subtest: addfb25-yf-tiled-legacy
[76.869559] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[76.945103] [061/164] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[77.095642] Starting subtest: addfb25-y-tiled-legacy
[77.114921] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[77.191743] [062/164] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.338185] Starting subtest: addfb25-y-tiled-small-legacy
[77.377892] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.459696] [063/164] (921s left) kms_addfb_basic (bad-pitch-0)
[77.604892] Starting subtest: bad-pitch-0
[77.625882] Subtest bad-pitch-0: SUCCESS (0.000s)
[77.702429] [064/164] (921s left) kms_addfb_basic (bad-pitch-1024)
[77.863146] Starting subtest: bad-pitch-1024
[77.882395] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.958061] [065/164] (921s left) kms_addfb_basic (bad-pitch-128)
[78.107631] Starting subtest: bad-pitch-128
[78.126828] Subtest bad-pitch-128: SUCCESS (0.000s)
[78.207440] [066/164] (921s left) kms_addfb_basic (bad-pitch-256)
[78.353327] Starting subtest: bad-pitch-256
[78.375183] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.453669] [067/164] (921s left) kms_addfb_basic (bad-pitch-32)
[78.604389] Starting subtest: bad-pitch-32
[78.625684] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.703277] [068/164] (921s left) kms_addfb_basic (bad-pitch-63)
[78.856723] Starting subtest: bad-pitch-63
[78.876023] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.950816] [069/164] (920s left) kms_addfb_basic (bad-pitch-65536)
[79.098363] Starting subtest: bad-pitch-65536
[79.117699] Subtest bad-pitch-65536: SUCCESS (0.000s)
[79.196800] [070/164] (920s left) kms_addfb_basic (bad-pitch-999)
[79.340182] Starting subtest: bad-pitch-999
[79.364753] Subtest bad-pitch-999: SUCCESS (0.000s)
[79.443611] [071/164] (920s left) kms_addfb_basic (basic)
[79.594140] Starting subtest: basic
[79.615360] Subtest basic: SUCCESS (0.000s)
[79.690341] [072/164] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.842389] Starting subtest: basic-x-tiled-legacy
[79.861514] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.935702] [073/164] (920s left) kms_addfb_basic (basic-y-tiled-legacy)
[80.085305] Starting subtest: basic-y-tiled-legacy
[80.104625] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[80.184757] [074/164] (919s left) kms_addfb_basic (bo-too-small)
[80.329231] Starting subtest: bo-too-small
[80.351171] Subtest bo-too-small: SUCCESS (0.000s)
[80.429247] [075/164] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.569944] Starting subtest: bo-too-small-due-to-tiling
[80.589101] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[80.689496] [076/164] (919s left) kms_addfb_basic (clobberred-modifier)
[80.869304] Starting subtest: clobberred-modifier
[80.895259] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.992278] [077/164] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.161144] Starting subtest: framebuffer-vs-set-tiling
[81.184664] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[81.285048] [078/164] (919s left) kms_addfb_basic (invalid-get-prop)
[81.456408] Starting subtest: invalid-get-prop
[81.487609] Subtest invalid-get-prop: SUCCESS (0.000s)
[81.583609] [079/164] (918s left) kms_addfb_basic (invalid-get-prop-any)
[81.754036] Starting subtest: invalid-get-prop-any
[81.783218] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[81.879516] [080/164] (918s left) kms_addfb_basic (invalid-set-prop)
[82.056569] Starting subtest: invalid-set-prop
[82.083140] Subtest invalid-set-prop: SUCCESS (0.000s)
[82.176313] [081/164] (918s left) kms_addfb_basic (invalid-set-prop-any)
[82.353046] Starting subtest: invalid-set-prop-any
[82.380338] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[82.480802] [082/164] (918s left) kms_addfb_basic (no-handle)
[82.657994] Starting subtest: no-handle
[82.683688] Subtest no-handle: SUCCESS (0.000s)
[82.771854] [083/164] (917s left) kms_addfb_basic (size-max)
[82.925852] Starting subtest: size-max
[82.945463] Subtest size-max: SUCCESS (0.000s)
[83.024551] [084/164] (917s left) kms_addfb_basic (small-bo)
[83.171804] Starting subtest: small-bo
[83.192625] Subtest small-bo: SUCCESS (0.000s)
[83.273584] [085/164] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[83.418729] Starting subtest: tile-pitch-mismatch
[83.443425] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[83.539783] [086/164] (917s left) kms_addfb_basic (too-high)
[83.691465] Starting subtest: too-high
[83.711819] Subtest too-high: SUCCESS (0.001s)
[83.786965] [087/164] (917s left) kms_addfb_basic (too-wide)
[83.931875] Starting subtest: too-wide
[83.950996] Subtest too-wide: SUCCESS (0.000s)
[84.030113] [088/164] (917s left) kms_addfb_basic (unused-handle)
[84.164027] Starting subtest: unused-handle
[84.184887] Subtest unused-handle: SUCCESS (0.000s)
[84.264952] [089/164] (916s left) kms_addfb_basic (unused-modifier)
[84.409849] Starting subtest: unused-modifier
[84.432197] Subtest unused-modifier: SUCCESS (0.000s)
[84.512880] [090/164] (916s left) kms_addfb_basic (unused-offsets)
[84.673900] Starting subtest: unused-offsets
[84.693569] Subtest unused-offsets: SUCCESS (0.000s)
[84.767578] [091/164] (916s left) kms_addfb_basic (unused-pitches)
[84.915677] Starting subtest: unused-pitches
[84.935079] Subtest unused-pitches: SUCCESS (0.000s)
[85.015919] [092/164] (916s left) kms_busy (basic)
[85.174874] Starting subtest: basic
[85.197062] Starting dynamic subtest: flip
[85.809899] Dynamic subtest flip: SUCCESS (0.639s)
[85.838930] Starting dynamic subtest: modeset
[86.336673] Dynamic subtest modeset: SUCCESS (0.530s)
[86.358450] Subtest basic: SUCCESS (1.169s)
[86.494400] [093/164] (914s left) kms_prop_blob (basic)
[86.655402] Starting subtest: basic
[86.674895] Subtest basic: SUCCESS (0.000s)
[86.751274] [094/164] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[86.907115] Starting subtest: basic-busy-flip-before-cursor-atomic
[87.840177] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.936s)
[87.985371] [095/164] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[88.131751] Starting subtest: basic-busy-flip-before-cursor-legacy
[89.056471] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.936s)
[89.218905] [096/164] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[89.361722] Starting subtest: basic-flip-after-cursor-atomic
[90.275833] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.925s)
[90.434950] [097/164] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[90.584354] Starting subtest: basic-flip-after-cursor-legacy
[91.513930] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s)
[91.669432] [098/164] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[91.825152] Starting subtest: basic-flip-after-cursor-varying-size
[92.757550] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s)
[92.905172] [099/164] (908s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[93.064652] Starting subtest: basic-flip-before-cursor-atomic
[93.976085] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s)
[94.121913] [100/164] (907s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[94.273420] Starting subtest: basic-flip-before-cursor-legacy
[95.199296] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.936s)
[95.348327] [101/164] (906s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[95.498372] Starting subtest: basic-flip-before-cursor-varying-size
[96.424539] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.933s)
[96.571112] [102/164] (905s left) kms_flip (basic-flip-vs-dpms)
[96.743299] Starting subtest: basic-flip-vs-dpms
[96.763405] Starting dynamic subtest: A-VGA1
[97.674864] Dynamic subtest A-VGA1: SUCCESS (0.962s)
[97.703474] Starting dynamic subtest: B-VGA1
[98.577041] Dynamic subtest B-VGA1: SUCCESS (0.907s)
[98.606780] Starting dynamic subtest: C-VGA1
[99.479108] Dynamic subtest C-VGA1: SUCCESS (0.898s)
[99.497820] Subtest basic-flip-vs-dpms: SUCCESS (2.770s)
[99.643859] [103/164] (902s left) kms_flip (basic-flip-vs-modeset)
[99.815038] Starting subtest: basic-flip-vs-modeset
[99.835249] Starting dynamic subtest: A-VGA1
[100.671650] Dynamic subtest A-VGA1: SUCCESS (0.893s)
[100.698502] Starting dynamic subtest: B-VGA1
[101.479625] Dynamic subtest B-VGA1: SUCCESS (0.796s)
[101.508288] Starting dynamic subtest: C-VGA1
[102.285590] Dynamic subtest C-VGA1: SUCCESS (0.812s)
[102.309208] Subtest basic-flip-vs-modeset: SUCCESS (2.504s)
[102.443430] [104/164] (899s left) kms_flip (basic-flip-vs-wf_vblank)
[102.632095] Starting subtest: basic-flip-vs-wf_vblank
[102.654805] Starting dynamic subtest: A-VGA1
[103.736933] Dynamic subtest A-VGA1: SUCCESS (1.154s)
[103.768336] Starting dynamic subtest: B-VGA1
[104.869274] Dynamic subtest B-VGA1: SUCCESS (1.126s)
[104.902811] Starting dynamic subtest: C-VGA1
[105.991920] Dynamic subtest C-VGA1: SUCCESS (1.125s)
[106.012816] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.411s)
[106.189879] [105/164] (896s left) kms_flip (basic-plain-flip)
[106.345586] Starting subtest: basic-plain-flip
[106.367280] Starting dynamic subtest: A-VGA1
[107.171722] Dynamic subtest A-VGA1: SUCCESS (0.871s)
[107.201406] Starting dynamic subtest: B-VGA1
[108.012089] Dynamic subtest B-VGA1: SUCCESS (0.840s)
[108.037263] Starting dynamic subtest: C-VGA1
[108.855725] Dynamic subtest C-VGA1: SUCCESS (0.841s)
[108.875163] Subtest basic-plain-flip: SUCCESS (2.558s)
[109.055244] [106/164] (893s left) kms_force_connector_basic (force-connector-state)
[109.205099] Starting subtest: force-connector-state
[109.306336] Subtest force-connector-state: SUCCESS (0.127s)
[109.501954] [107/164] (892s left) kms_force_connector_basic (force-edid)
[109.651749] Starting subtest: force-edid
[109.690565] Subtest force-edid: SUCCESS (0.062s)
[109.813570] [108/164] (892s left) kms_force_connector_basic (force-load-detect)
[109.964551] Starting subtest: force-load-detect
[110.099370] Subtest force-load-detect: SUCCESS (0.145s)
[110.302951] [109/164] (892s left) kms_force_connector_basic (prune-stale-modes)
[110.447836] Starting subtest: prune-stale-modes
[110.468045] Subtest prune-stale-modes: SUCCESS (0.016s)
[110.571651] [110/164] (891s left) kms_frontbuffer_tracking (basic)
[110.789418] Starting subtest: basic
[112.548123] Subtest basic: SUCCESS (1.835s)
[112.647672] [111/164] (889s left) kms_hdmi_inject (inject-audio)
[112.820448] Starting subtest: inject-audio
[112.860040] Subtest inject-audio: SKIP (0.000s)
[112.962335] [112/164] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[113.114987] Starting subtest: compare-crc-sanitycheck-xr24
[113.136331] Starting dynamic subtest: pipe-A-VGA-1
[113.363088] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.264s)
[113.390104] Starting dynamic subtest: pipe-B-VGA-1
[113.629036] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.262s)
[113.655280] Starting dynamic subtest: pipe-C-VGA-1
[113.892024] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.264s)
[113.910770] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.792s)
[114.047031] [113/164] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[114.188936] Starting subtest: compare-crc-sanitycheck-nv12
[114.210872] Starting dynamic subtest: pipe-A-VGA-1
[114.253689] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[114.279993] Starting dynamic subtest: pipe-B-VGA-1
[114.318749] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[114.344585] Starting dynamic subtest: pipe-C-VGA-1
[114.387160] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[114.430314] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[114.505593] [114/164] (888s left) kms_pipe_crc_basic (hang-read-crc)
[114.660173] Starting subtest: hang-read-crc
[114.679549] Starting dynamic subtest: pipe-A-VGA-1
[115.407608] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.763s)
[115.434865] Starting dynamic subtest: pipe-B-VGA-1
[116.165438] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.757s)
[116.190394] Starting dynamic subtest: pipe-C-VGA-1
[116.928827] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.760s)
[116.950026] Subtest hang-read-crc: SUCCESS (2.283s)
[117.072989] [115/164] (885s left) kms_pipe_crc_basic (nonblocking-crc)
[117.220106] Starting subtest: nonblocking-crc
[117.239382] Starting dynamic subtest: pipe-A-VGA-1
[117.660978] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.447s)
[117.688178] Starting dynamic subtest: pipe-B-VGA-1
[118.108577] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.445s)
[118.133985] Starting dynamic subtest: pipe-C-VGA-1
[118.547201] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.446s)
[118.568831] Subtest nonblocking-crc: SUCCESS (1.341s)
[118.695318] [116/164] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[118.848122] Starting subtest: nonblocking-crc-frame-sequence
[118.867506] Starting dynamic subtest: pipe-A-VGA-1
[119.278202] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.449s)
[119.303179] Starting dynamic subtest: pipe-B-VGA-1
[119.728776] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.446s)
[119.755530] Starting dynamic subtest: pipe-C-VGA-1
[120.183046] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.446s)
[120.203069] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.345s)
[120.325616] [117/164] (882s left) kms_pipe_crc_basic (read-crc)
[120.466463] Starting subtest: read-crc
[120.486030] Starting dynamic subtest: pipe-A-VGA-1
[120.856887] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.379s)
[120.892261] Starting dynamic subtest: pipe-B-VGA-1
[121.242762] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.379s)
[121.278442] Starting dynamic subtest: pipe-C-VGA-1
[121.617984] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.378s)
[121.644359] Subtest read-crc: SUCCESS (1.139s)
[121.776217] [118/164] (881s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[121.962947] Starting subtest: read-crc-frame-sequence
[121.989686] Starting dynamic subtest: pipe-A-VGA-1
[122.326977] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.381s)
[122.360720] Starting dynamic subtest: pipe-B-VGA-1
[122.679311] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.375s)
[122.711544] Starting dynamic subtest: pipe-C-VGA-1
[123.080574] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.379s)
[123.101328] Subtest read-crc-frame-sequence: SUCCESS (1.138s)
[123.203981] [119/164] (879s left) kms_pm_backlight (basic-brightness)
[123.379237] Subtest basic-brightness: SKIP (0.000s)
[123.455334] [120/164] (879s left) kms_psr (primary_page_flip)
[123.631688] Subtest primary_page_flip: SKIP (0.000s)
[123.707807] [121/164] (879s left) kms_psr (cursor_plane_move)
[123.876475] Subtest cursor_plane_move: SKIP (0.000s)
[123.956647] [122/164] (879s left) kms_psr (sprite_plane_onoff)
[124.122746] Subtest sprite_plane_onoff: SKIP (0.000s)
[124.209294] [123/164] (879s left) kms_psr (primary_mmap_gtt)
[124.379576] Subtest primary_mmap_gtt: SKIP (0.000s)
[124.455224] [124/164] (879s left) kms_setmode (basic-clone-single-crtc)
[124.613320] Starting subtest: basic-clone-single-crtc
[124.671549] Subtest basic-clone-single-crtc: SKIP (0.000s)
[124.751998] [125/164] (878s left) i915_pm_rpm (basic-pci-d3-state)
[136.047236] Subtest basic-pci-d3-state: SKIP (0.000s)
[136.129761] [126/164] (867s left) i915_pm_rpm (basic-rte)
[136.254955] Starting subtest: basic-rte
[147.412748] Subtest basic-rte: SKIP (11.100s)
[147.529645] [127/164] (856s left) i915_pm_rps (basic-api)
[147.686050] Starting subtest: basic-api
[147.705668] Subtest basic-api: SUCCESS (0.002s)
[147.807811] [128/164] (856s left) prime_self_import (basic-llseek-bad)
[147.938567] Starting subtest: basic-llseek-bad
[147.980076] Subtest basic-llseek-bad: SUCCESS (0.002s)
[148.061732] [129/164] (855s left) prime_self_import (basic-llseek-size)
[148.186203] Starting subtest: basic-llseek-size
[148.229514] Subtest basic-llseek-size: SUCCESS (0.003s)
[148.306957] [130/164] (855s left) prime_self_import (basic-with_fd_dup)
[148.439570] Starting subtest: basic-with_fd_dup
[148.480557] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[148.554263] [131/164] (855s left) prime_self_import (basic-with_one_bo)
[148.683277] Starting subtest: basic-with_one_bo
[148.721527] Subtest basic-with_one_bo: SUCCESS (0.002s)
[148.800538] [132/164] (855s left) prime_self_import (basic-with_one_bo_two_files)
[148.915567] Starting subtest: basic-with_one_bo_two_files
[148.953597] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[149.035049] [133/164] (855s left) prime_self_import (basic-with_two_bos)
[149.144237] Starting subtest: basic-with_two_bos
[149.185978] Subtest basic-with_two_bos: SUCCESS (0.002s)
[149.266393] [134/164] (855s left) prime_vgem (basic-fence-flip)
[149.440380] Starting subtest: basic-fence-flip
[149.723958] Subtest basic-fence-flip: SUCCESS (0.330s)
[149.851126] [135/164] (854s left) prime_vgem (basic-fence-mmap)
[149.999602] Starting subtest: basic-fence-mmap
[150.021281] Subtest basic-fence-mmap: SUCCESS (0.027s)
[150.118897] [136/164] (854s left) prime_vgem (basic-fence-read)
[150.288199] Starting subtest: basic-fence-read
[150.307760] Subtest basic-fence-read: SUCCESS (0.042s)
[150.407940] [137/164] (854s left) prime_vgem (basic-gtt)
[150.573517] Starting subtest: basic-gtt
[150.597741] Subtest basic-gtt: SUCCESS (0.014s)
[150.695634] [138/164] (853s left) prime_vgem (basic-read)
[150.867029] Starting subtest: basic-read
[150.886459] Subtest basic-read: SUCCESS (0.018s)
[150.985190] [139/164] (853s left) prime_vgem (basic-write)
[151.152858] Starting subtest: basic-write
[151.174772] Subtest basic-write: SUCCESS (0.020s)
[151.271678] [140/164] (853s left) vgem_basic (setversion)
[151.409522] Starting subtest: setversion
[151.450095] Subtest setversion: SUCCESS (0.000s)
[151.524862] [141/164] (853s left) vgem_basic (create)
[151.673510] Starting subtest: create
[151.693074] Subtest create: SUCCESS (0.000s)
[151.772258] [142/164] (853s left) vgem_basic (debugfs)
[151.924135] Starting subtest: debugfs
[151.945855] Subtest debugfs: SUCCESS (0.000s)
[152.027115] [143/164] (853s left) vgem_basic (dmabuf-export)
[152.178689] Starting subtest: dmabuf-export
[152.221449] Subtest dmabuf-export: SUCCESS (0.003s)
[152.301828] [144/164] (852s left) vgem_basic (dmabuf-fence)
[152.456669] Starting subtest: dmabuf-fence
[152.476194] Subtest dmabuf-fence: SUCCESS (0.001s)
[152.552690] [145/164] (852s left) vgem_basic (dmabuf-fence-before)
[152.698461] Starting subtest: dmabuf-fence-before
[152.717753] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[152.800330] [146/164] (852s left) vgem_basic (dmabuf-mmap)
[152.945109] Starting subtest: dmabuf-mmap
[152.966751] Subtest dmabuf-mmap: SUCCESS (0.018s)
[153.045487] [147/164] (852s left) vgem_basic (mmap)
[153.175844] Starting subtest: mmap
[153.197355] Subtest mmap: SUCCESS (0.011s)
[153.273324] [148/164] (852s left) vgem_basic (second-client)
[153.413311] Starting subtest: second-client
[153.453462] Subtest second-client: SUCCESS (0.033s)
[153.527326] [149/164] (851s left) vgem_basic (sysfs)
[153.684400] Starting subtest: sysfs
[153.703544] Subtest sysfs: SUCCESS (0.001s)
[153.784467] [150/164] (851s left) core_hotunplug (unbind-rebind)
[153.979643] Starting subtest: unbind-rebind
[156.725331] Subtest unbind-rebind: SUCCESS (2.744s)
[156.802584] [151/164] (848s left) vgem_basic (unload)
[156.923784] Starting subtest: unload
[186.005412] Subtest unload: SUCCESS (28.907s)
[186.084856] [152/164] (819s left) i915_module_load (reload)
[186.216894] Starting subtest: reload
[188.125449] Subtest reload: SUCCESS (1.916s)
[188.202171] [153/164] (817s left) gem_lmem_swapping (basic)
[188.385446] Subtest basic: SKIP (0.000s)
[188.499271] [154/164] (817s left) gem_lmem_swapping (parallel-random-engines)
[188.697237] Subtest parallel-random-engines: SKIP (0.000s)
[188.798343] [155/164] (817s left) gem_lmem_swapping (random-engines)
[188.980085] Subtest random-engines: SKIP (0.000s)
[189.075469] [156/164] (817s left) gem_lmem_swapping (verify-random)
[189.265670] Subtest verify-random: SKIP (0.000s)
[189.361495] [157/164] (817s left) i915_pm_rpm (module-reload)
[200.666296] Subtest module-reload: SKIP (0.000s)
[200.739662] [158/164] (805s left) i915_selftest (live)
[201.522452] Starting subtest: live
[201.544086] Starting dynamic subtest: sanitycheck
[202.162877] Dynamic subtest sanitycheck: SUCCESS (0.642s)
[202.188750] Starting dynamic subtest: uncore
[202.797257] Dynamic subtest uncore: SUCCESS (0.629s)
[202.824468] Starting dynamic subtest: workarounds
[203.443177] Dynamic subtest workarounds: SUCCESS (0.646s)
[203.473893] Starting dynamic subtest: gt_engines
[204.102032] Dynamic subtest gt_engines: SUCCESS (0.658s)
[204.128191] Starting dynamic subtest: gt_timelines
[209.474364] Dynamic subtest gt_timelines: SUCCESS (5.368s)
[209.502643] Starting dynamic subtest: gt_contexts
[210.159806] Dynamic subtest gt_contexts: SUCCESS (0.686s)
[210.187078] Starting dynamic subtest: gt_lrc
[210.786876] Dynamic subtest gt_lrc: SUCCESS (0.624s)
[210.813669] Starting dynamic subtest: gt_mocs
[211.402815] Dynamic subtest gt_mocs: SUCCESS (0.616s)
[211.430132] Starting dynamic subtest: gt_pm
[219.842554] Dynamic subtest gt_pm: SUCCESS (8.437s)
[219.868592] Starting dynamic subtest: gt_heartbeat
[220.539753] Dynamic subtest gt_heartbeat: SUCCESS (0.694s)
[220.565788] Starting dynamic subtest: gt_tlb
[221.164539] Dynamic subtest gt_tlb: SUCCESS (0.625s)
[221.193036] Starting dynamic subtest: requests
[226.431849] Dynamic subtest requests: SUCCESS (5.264s)
[226.460464] Starting dynamic subtest: migrate
[227.066826] Dynamic subtest migrate: SUCCESS (0.633s)
[227.092804] Starting dynamic subtest: active
[227.716292] Dynamic subtest active: SUCCESS (0.647s)
[227.748700] Starting dynamic subtest: objects
[228.712710] Dynamic subtest objects: SUCCESS (0.996s)
[228.740084] Starting dynamic subtest: mman
[232.736596] Dynamic subtest mman: SUCCESS (4.019s)
[232.764217] Starting dynamic subtest: dmabuf
[233.417659] Dynamic subtest dmabuf: SUCCESS (0.679s)
[233.445713] Starting dynamic subtest: vma
[234.054880] Dynamic subtest vma: SUCCESS (0.638s)
[234.082087] Starting dynamic subtest: coherency
[235.796596] Dynamic subtest coherency: SUCCESS (1.734s)
[235.825127] Starting dynamic subtest: gtt
[239.807141] Dynamic subtest gtt: SUCCESS (4.012s)
[239.834961] Starting dynamic subtest: gem
[240.475476] Dynamic subtest gem: SUCCESS (0.667s)
[240.504038] Starting dynamic subtest: evict
[241.081799] Dynamic subtest evict: SUCCESS (0.605s)
[241.107699] Starting dynamic subtest: hugepages
[242.845785] Dynamic subtest hugepages: SUCCESS (1.763s)
[242.871829] Starting dynamic subtest: gem_contexts
[247.144444] Dynamic subtest gem_contexts: SUCCESS (4.297s)
[247.173245] Starting dynamic subtest: client
[247.780856] Dynamic subtest client: SUCCESS (0.632s)
[247.806921] Starting dynamic subtest: gem_migrate
[248.396485] Dynamic subtest gem_migrate: SUCCESS (0.616s)
[248.425124] Starting dynamic subtest: reset
[249.028618] Dynamic subtest reset: SUCCESS (0.628s)
[249.054388] Starting dynamic subtest: memory_region
[249.655602] Dynamic subtest memory_region: SUCCESS (0.627s)
[249.684196] Starting dynamic subtest: hangcheck
[263.002785] Dynamic subtest hangcheck: SUCCESS (13.345s)
[263.028859] Starting dynamic subtest: execlists
[263.622812] Dynamic subtest execlists: SUCCESS (0.616s)
[263.651221] Starting dynamic subtest: ring_submission
[264.311711] Dynamic subtest ring_submission: SUCCESS (0.689s)
[264.337540] Starting dynamic subtest: perf
[264.951769] Dynamic subtest perf: SUCCESS (0.636s)
[264.979926] Starting dynamic subtest: slpc
[265.596126] Dynamic subtest slpc: SUCCESS (0.644s)
[265.624591] Starting dynamic subtest: guc
[266.178536] Dynamic subtest guc: SUCCESS (0.579s)
[266.204590] Starting dynamic subtest: guc_multi_lrc
[266.805702] Dynamic subtest guc_multi_lrc: SUCCESS (0.627s)
[266.834712] Starting dynamic subtest: guc_hang
[267.436258] Dynamic subtest guc_hang: SUCCESS (0.627s)
[267.466590] Starting dynamic subtest: late_gt_pm
[268.070181] Dynamic subtest late_gt_pm: SUCCESS (0.631s)
[268.092170] Subtest live: SUCCESS (66.548s)
[268.169373] [159/164] (738s left) dmabuf (all-tests)
[268.295519] Starting subtest: all-tests
[268.316751] Starting dynamic subtest: sanitycheck
[268.374502] Dynamic subtest sanitycheck: SUCCESS (0.089s)
[268.398265] Starting dynamic subtest: dma_fence
[268.550679] Dynamic subtest dma_fence: SUCCESS (0.171s)
[268.579065] Starting dynamic subtest: dma_fence_chain
[280.315904] Dynamic subtest dma_fence_chain: SUCCESS (11.766s)
[280.346087] Starting dynamic subtest: dma_fence_unwrap
[280.393372] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[280.426515] Starting dynamic subtest: dma_resv
[280.470832] Dynamic subtest dma_resv: SUCCESS (0.075s)
[280.490274] Subtest all-tests: SUCCESS (12.183s)
[280.563037] [160/164] (726s left) i915_suspend (basic-s2idle-without-i915)
[280.683366] Starting subtest: basic-s2idle-without-i915
[298.194102] Subtest basic-s2idle-without-i915: SUCCESS (2.080s)
[301.499966] [161/164] (724s left) i915_suspend (basic-s3-without-i915)
[301.619660] Starting subtest: basic-s3-without-i915
[319.253002] Subtest basic-s3-without-i915: SUCCESS (1.890s)
[322.397407] [162/164] (721s left) gem_exec_suspend (basic-s0)
[322.560277] Starting subtest: basic-S0
[322.581041] Starting dynamic subtest: smem
[340.145484] Dynamic subtest smem: SUCCESS (1.539s)
[340.165065] Subtest basic-S0: SUCCESS (1.541s)
[343.152266] [163/164] (720s left) gem_exec_suspend (basic-s3)
[343.297729] Starting subtest: basic-S3
[343.316444] Starting dynamic subtest: smem
[361.068424] Dynamic subtest smem: SUCCESS (1.596s)
[361.087984] Subtest basic-S3: SUCCESS (1.597s)
[364.130139] [164/164] (718s left) kms_pipe_crc_basic (suspend-read-crc)
[364.274266] Starting subtest: suspend-read-crc
[364.296086] Starting dynamic subtest: pipe-A-VGA-1
[382.213284] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.629s)
[382.243889] Starting dynamic subtest: pipe-B-VGA-1
[400.214680] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.666s)
[400.241419] Starting dynamic subtest: pipe-C-VGA-1
[418.199671] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.666s)
[418.219822] Subtest suspend-read-crc: SUCCESS (4.965s)
[422.335995] Closing watchdogs
Done.