[36.168359] Initializing watchdogs
[36.168489]   /dev/watchdog0
[36.175829] [001/165] (960s left) i915_module_load (load)
[36.537259] Starting subtest: load
[38.163476] Subtest load: SUCCESS (1.628s)
[38.190653] [002/165] (958s left) core_auth (basic-auth)
[38.307691] Starting subtest: basic-auth
[38.313119] Subtest basic-auth: SUCCESS (0.007s)
[38.394073] [003/165] (958s left) debugfs_test (read_all_entries)
[38.509611] Starting subtest: read_all_entries
[38.573238] Subtest read_all_entries: SUCCESS (0.058s)
[38.788225] [004/165] (957s left) debugfs_test (basic-hwmon)
[38.966278] Starting subtest: basic-hwmon
[38.969846] Subtest basic-hwmon: SKIP (0.000s)
[39.074418] [005/165] (957s left) fbdev (eof)
[39.190033] Starting subtest: eof
[39.192314] Subtest eof: SUCCESS (0.003s)
[39.243888] [006/165] (957s left) fbdev (info)
[39.338174] Starting subtest: info
[39.341686] Subtest info: SUCCESS (0.000s)
[39.409497] [007/165] (957s left) fbdev (nullptr)
[39.523616] Starting subtest: nullptr
[39.524814] Subtest nullptr: SUCCESS (0.000s)
[39.577155] [008/165] (957s left) fbdev (read)
[39.688396] Starting subtest: read
[39.955591] Subtest read: SUCCESS (0.265s)
[40.013495] [009/165] (956s left) fbdev (write)
[40.122177] Starting subtest: write
[40.290545] Subtest write: SUCCESS (0.167s)
[40.345296] [010/165] (956s left) gem_basic (bad-close)
[40.448864] Starting subtest: bad-close
[40.451525] Subtest bad-close: SUCCESS (0.000s)
[40.513864] [011/165] (956s left) gem_basic (create-close)
[40.613042] Starting subtest: create-close
[40.615464] Subtest create-close: SUCCESS (0.000s)
[40.680040] [012/165] (956s left) gem_basic (create-fd-close)
[40.780112] Starting subtest: create-fd-close
[40.785160] Subtest create-fd-close: SUCCESS (0.001s)
[40.863915] [013/165] (956s left) gem_busy (busy@all-engines)
[40.983725] Starting subtest: busy
[40.989827] Starting dynamic subtest: all-engines
[41.020455] Dynamic subtest all-engines: SUCCESS (0.035s)
[41.021801] Subtest busy: SUCCESS (0.036s)
[41.334828] [014/165] (955s left) gem_close_race (basic-process)
[41.440754] Starting subtest: basic-process
[41.490384] Subtest basic-process: SUCCESS (0.050s)
[41.669100] [015/165] (955s left) gem_close_race (basic-threads)
[41.772863] Starting subtest: basic-threads
[42.931368] Subtest basic-threads: SUCCESS (1.158s)
[43.108466] [016/165] (953s left) gem_ctx_create (basic)
[43.201931] Subtest basic: SKIP (0.000s)
[43.243424] [017/165] (953s left) gem_ctx_create (basic-files)
[43.395281] Subtest basic-files: SKIP (0.000s)
[43.443159] [018/165] (953s left) gem_ctx_exec (basic)
[43.538211] Subtest basic: SKIP (0.000s)
[43.592078] [019/165] (953s left) gem_exec_basic (basic)
[43.690746] Starting subtest: basic
[43.691826] Starting dynamic subtest: rcs0-smem
[43.693000] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[43.694085] Subtest basic: SUCCESS (0.001s)
[43.877421] [020/165] (953s left) gem_exec_create (basic)
[43.981774] Starting subtest: basic
[43.982870] Starting dynamic subtest: smem
[46.020495] Dynamic subtest smem: SUCCESS (2.040s)
[46.021677] Subtest basic: SUCCESS (2.041s)
[46.201334] [021/165] (950s left) gem_exec_fence (basic-busy)
[46.428393] Starting subtest: basic-busy
[46.429553] Starting dynamic subtest: rcs0
[46.448097] Dynamic subtest rcs0: SUCCESS (0.019s)
[46.449262] Subtest basic-busy: SUCCESS (0.020s)
[46.939808] [022/165] (950s left) gem_exec_fence (basic-wait)
[47.170253] Starting subtest: basic-wait
[47.171368] Starting dynamic subtest: rcs0
[47.181250] Dynamic subtest rcs0: SUCCESS (0.012s)
[47.182366] Subtest basic-wait: SUCCESS (0.013s)
[47.623578] [023/165] (949s left) gem_exec_fence (basic-await)
[47.851448] Starting subtest: basic-await
[47.852525] Starting dynamic subtest: rcs0
[47.913901] Dynamic subtest rcs0: SUCCESS (0.063s)
[47.915321] Subtest basic-await: SUCCESS (0.064s)
[48.359458] [024/165] (948s left) gem_exec_fence (nb-await)
[48.587694] Starting subtest: nb-await
[48.588884] Starting dynamic subtest: rcs0
[48.639664] Dynamic subtest rcs0: SUCCESS (0.053s)
[48.640974] Subtest nb-await: SUCCESS (0.054s)
[49.095390] [025/165] (948s left) gem_exec_gttfill (basic)
[49.199221] Starting subtest: basic
[52.613864] Subtest basic: SUCCESS (3.415s)
[52.795320] [026/165] (944s left) gem_exec_parallel (engines)
[53.012943] Starting subtest: engines
[53.017598] Starting dynamic subtest: basic
[55.228048] Dynamic subtest basic: SUCCESS (2.213s)
[55.239062] Starting dynamic subtest: contexts
[55.241808] Dynamic subtest contexts: SKIP (0.001s)
[55.255181] Starting dynamic subtest: fds
[55.257836] Dynamic subtest fds: SKIP (0.000s)
[55.268605] Starting dynamic subtest: userptr
[57.725279] Dynamic subtest userptr: SUCCESS (2.497s)
[57.727855] Subtest engines: SUCCESS (4.712s)
[57.910453] [027/165] (939s left) gem_exec_store (basic)
[58.012435] Starting subtest: basic
[58.033716] Subtest basic: SUCCESS (0.022s)
[58.210448] [028/165] (939s left) gem_flink_basic (bad-flink)
[58.299760] Starting subtest: bad-flink
[58.300966] Subtest bad-flink: SUCCESS (0.000s)
[58.375318] [029/165] (938s left) gem_flink_basic (bad-open)
[58.463919] Starting subtest: bad-open
[58.466102] Subtest bad-open: SUCCESS (0.000s)
[58.529929] [030/165] (938s left) gem_flink_basic (basic)
[58.619856] Starting subtest: basic
[58.620943] Subtest basic: SUCCESS (0.000s)
[58.695447] [031/165] (938s left) gem_flink_basic (double-flink)
[58.782076] Starting subtest: double-flink
[58.783300] Subtest double-flink: SUCCESS (0.000s)
[58.859786] [032/165] (938s left) gem_flink_basic (flink-lifetime)
[58.950009] Starting subtest: flink-lifetime
[58.951238] Subtest flink-lifetime: SUCCESS (0.001s)
[59.029216] [033/165] (938s left) gem_huc_copy (huc-copy)
[59.126090] Subtest huc-copy: SKIP (0.000s)
[59.164880] [034/165] (938s left) gem_linear_blits (basic)
[59.468160] Starting subtest: basic
[59.480538] Subtest basic: SUCCESS (0.013s)
[59.598534] [035/165] (937s left) gem_mmap (basic)
[59.823035] Starting subtest: basic
[59.828493] Subtest basic: SUCCESS (0.000s)
[59.899238] [036/165] (937s left) gem_mmap_gtt (basic)
[59.995267] Starting subtest: basic
[59.996339] Subtest basic: SUCCESS (0.001s)
[60.067871] [037/165] (937s left) gem_render_linear_blits (basic)
[60.163347] Starting subtest: basic
[60.219846] Subtest basic: SUCCESS (0.054s)
[60.269281] [038/165] (937s left) gem_render_tiled_blits (basic)
[60.364304] Starting subtest: basic
[60.408442] Subtest basic: SUCCESS (0.045s)
[60.453610] [039/165] (937s left) gem_ringfill (basic-all)
[60.572491] Starting subtest: basic-all
[61.678672] Subtest basic-all: SUCCESS (1.102s)
[61.757361] [040/165] (935s left) gem_softpin (allocator-basic)
[61.851973] Subtest allocator-basic: SKIP (0.000s)
[61.923286] [041/165] (935s left) gem_softpin (allocator-basic-reserve)
[62.014481] Subtest allocator-basic-reserve: SKIP (0.000s)
[62.090276] [042/165] (935s left) gem_softpin (safe-alignment)
[62.184349] Starting subtest: safe-alignment
[62.187042] Subtest safe-alignment: SUCCESS (0.007s)
[62.257135] [043/165] (935s left) gem_sync (basic-all)
[62.361198] Starting subtest: basic-all
[64.501368] Subtest basic-all: SUCCESS (2.143s)
[64.683055] [044/165] (932s left) gem_sync (basic-each)
[64.784220] Starting subtest: basic-each
[66.890710] Subtest basic-each: SUCCESS (2.106s)
[67.075029] [045/165] (930s left) gem_tiled_blits (basic)
[67.359307] Starting subtest: basic
[67.383825] Subtest basic: SUCCESS (0.023s)
[67.491674] [046/165] (930s left) gem_tiled_fence_blits (basic)
[67.889566] Starting subtest: basic
[67.902857] Subtest basic: SUCCESS (0.013s)
[68.010560] [047/165] (929s left) gem_tiled_pread_basic
[68.512594] [048/165] (929s left) gem_wait (busy@all-engines)
[68.627138] Starting subtest: busy
[68.628111] Starting dynamic subtest: all-engines
[69.134043] Dynamic subtest all-engines: SUCCESS (0.509s)
[69.135292] Subtest busy: SUCCESS (0.510s)
[69.348853] [049/165] (928s left) gem_wait (wait@all-engines)
[69.457149] Starting subtest: wait
[69.459072] Starting dynamic subtest: all-engines
[70.474852] Dynamic subtest all-engines: SUCCESS (1.016s)
[70.475939] Subtest wait: SUCCESS (1.016s)
[70.687147] [050/165] (927s left) i915_getparams_basic (basic-eu-total)
[70.777072] Starting subtest: basic-eu-total
[70.779244] Subtest basic-eu-total: SUCCESS (0.000s)
[70.853380] [051/165] (926s left) i915_getparams_basic (basic-subslice-total)
[70.943091] Starting subtest: basic-subslice-total
[70.945269] Subtest basic-subslice-total: SUCCESS (0.000s)
[71.004639] [052/165] (926s left) i915_hangman (error-state-basic)
[71.101857] Starting subtest: error-state-basic
[71.200446] Subtest error-state-basic: SUCCESS (0.095s)
[71.250440] [053/165] (926s left) i915_pciid
[71.419915] [054/165] (926s left) kms_addfb_basic (addfb25-4-tiled)
[71.541947] Starting subtest: addfb25-4-tiled
[71.543146] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[71.616343] [055/165] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[71.706990] Starting subtest: addfb25-bad-modifier
[71.708132] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[71.821176] [056/165] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[71.911217] Starting subtest: addfb25-framebuffer-vs-set-tiling
[71.912277] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[72.022594] [057/165] (925s left) kms_addfb_basic (addfb25-modifier-no-flag)
[72.111414] Starting subtest: addfb25-modifier-no-flag
[72.116037] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[72.221825] [058/165] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[72.312370] Starting subtest: addfb25-x-tiled-legacy
[72.313484] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[72.418866] [059/165] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[72.510204] Starting subtest: addfb25-x-tiled-mismatch-legacy
[72.511257] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[72.621707] [060/165] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[72.746408] Starting subtest: addfb25-yf-tiled-legacy
[72.749080] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[72.821430] [061/165] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.946981] Starting subtest: addfb25-y-tiled-legacy
[72.948107] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[73.025034] [062/165] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[73.149133] Starting subtest: addfb25-y-tiled-small-legacy
[73.152270] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[73.224709] [063/165] (924s left) kms_addfb_basic (bad-pitch-0)
[73.319050] Starting subtest: bad-pitch-0
[73.321156] Subtest bad-pitch-0: SUCCESS (0.000s)
[73.425946] [064/165] (924s left) kms_addfb_basic (bad-pitch-1024)
[73.520341] Starting subtest: bad-pitch-1024
[73.521483] Subtest bad-pitch-1024: SUCCESS (0.000s)
[73.627200] [065/165] (924s left) kms_addfb_basic (bad-pitch-128)
[73.715926] Starting subtest: bad-pitch-128
[73.720812] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.826470] [066/165] (924s left) kms_addfb_basic (bad-pitch-256)
[73.915544] Starting subtest: bad-pitch-256
[73.916656] Subtest bad-pitch-256: SUCCESS (0.000s)
[74.028386] [067/165] (924s left) kms_addfb_basic (bad-pitch-32)
[74.122903] Starting subtest: bad-pitch-32
[74.124098] Subtest bad-pitch-32: SUCCESS (0.000s)
[74.229292] [068/165] (923s left) kms_addfb_basic (bad-pitch-63)
[74.320801] Starting subtest: bad-pitch-63
[74.321918] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.428948] [069/165] (923s left) kms_addfb_basic (bad-pitch-65536)
[74.523294] Starting subtest: bad-pitch-65536
[74.524292] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.631704] [070/165] (923s left) kms_addfb_basic (bad-pitch-999)
[74.722235] Starting subtest: bad-pitch-999
[74.724216] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.828848] [071/165] (923s left) kms_addfb_basic (basic)
[74.918223] Starting subtest: basic
[74.919312] Subtest basic: SUCCESS (0.000s)
[75.030439] [072/165] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[75.121086] Starting subtest: basic-x-tiled-legacy
[75.122231] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.233711] [073/165] (923s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.327173] Starting subtest: basic-y-tiled-legacy
[75.328230] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.433213] [074/165] (922s left) kms_addfb_basic (bo-too-small)
[75.554234] Starting subtest: bo-too-small
[75.555696] Subtest bo-too-small: SUCCESS (0.001s)
[75.633659] [075/165] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.759255] Starting subtest: bo-too-small-due-to-tiling
[75.760444] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[75.832658] [076/165] (922s left) kms_addfb_basic (clobberred-modifier)
[75.930513] Starting subtest: clobberred-modifier
[75.931621] Subtest clobberred-modifier: SUCCESS (0.000s)
[76.035305] [077/165] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[76.129446] Starting subtest: framebuffer-vs-set-tiling
[76.130504] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.236463] [078/165] (922s left) kms_addfb_basic (invalid-get-prop)
[76.327106] Starting subtest: invalid-get-prop
[76.328149] Subtest invalid-get-prop: SUCCESS (0.000s)
[76.436217] [079/165] (921s left) kms_addfb_basic (invalid-get-prop-any)
[76.527134] Starting subtest: invalid-get-prop-any
[76.528244] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.637273] [080/165] (921s left) kms_addfb_basic (invalid-set-prop)
[76.728079] Starting subtest: invalid-set-prop
[76.732610] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.837684] [081/165] (921s left) kms_addfb_basic (invalid-set-prop-any)
[76.926828] Starting subtest: invalid-set-prop-any
[76.927895] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[77.036450] [082/165] (921s left) kms_addfb_basic (no-handle)
[77.127582] Starting subtest: no-handle
[77.128684] Subtest no-handle: SUCCESS (0.000s)
[77.237816] [083/165] (921s left) kms_addfb_basic (size-max)
[77.358933] Starting subtest: size-max
[77.361103] Subtest size-max: SUCCESS (0.000s)
[77.439251] [084/165] (921s left) kms_addfb_basic (small-bo)
[77.562257] Starting subtest: small-bo
[77.564159] Subtest small-bo: SUCCESS (0.000s)
[77.639756] [085/165] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[77.732486] Starting subtest: tile-pitch-mismatch
[77.734556] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.841321] [086/165] (920s left) kms_addfb_basic (too-high)
[77.964929] Starting subtest: too-high
[77.966299] Subtest too-high: SUCCESS (0.002s)
[78.041648] [087/165] (920s left) kms_addfb_basic (too-wide)
[78.164932] Starting subtest: too-wide
[78.166090] Subtest too-wide: SUCCESS (0.000s)
[78.241852] [088/165] (920s left) kms_addfb_basic (unused-handle)
[78.335331] Starting subtest: unused-handle
[78.336433] Subtest unused-handle: SUCCESS (0.000s)
[78.442912] [089/165] (920s left) kms_addfb_basic (unused-modifier)
[78.532330] Starting subtest: unused-modifier
[78.533403] Subtest unused-modifier: SUCCESS (0.000s)
[78.644387] [090/165] (920s left) kms_addfb_basic (unused-offsets)
[78.738164] Starting subtest: unused-offsets
[78.739257] Subtest unused-offsets: SUCCESS (0.000s)
[78.846076] [091/165] (919s left) kms_addfb_basic (unused-pitches)
[78.936202] Starting subtest: unused-pitches
[78.937283] Subtest unused-pitches: SUCCESS (0.000s)
[79.044489] [092/165] (919s left) kms_busy (basic)
[79.167697] Starting subtest: basic
[79.168916] Starting dynamic subtest: flip
[79.722111] Dynamic subtest flip: SUCCESS (0.549s)
[79.735852] Starting dynamic subtest: modeset
[79.738044] Dynamic subtest modeset: SKIP (0.000s)
[79.739140] Subtest basic: SUCCESS (0.551s)
[79.818407] [093/165] (918s left) kms_prop_blob (basic)
[79.912071] Starting subtest: basic
[79.913805] Subtest basic: SUCCESS (0.000s)
[79.984460] [094/165] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[80.110198] Starting subtest: basic-busy-flip-before-cursor-atomic
[80.112700] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[80.183482] [095/165] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[80.307495] Starting subtest: basic-busy-flip-before-cursor-legacy
[81.306407] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.000s)
[81.418556] [096/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[81.541808] Starting subtest: basic-flip-after-cursor-atomic
[81.544048] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[81.619479] [097/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[81.740633] Starting subtest: basic-flip-after-cursor-legacy
[82.739865] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[82.853133] [098/165] (916s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[82.976627] Starting subtest: basic-flip-after-cursor-varying-size
[83.972838] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.998s)
[84.085583] [099/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[84.208895] Starting subtest: basic-flip-before-cursor-atomic
[84.211097] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[84.285865] [100/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[84.425633] Starting subtest: basic-flip-before-cursor-legacy
[85.428878] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.004s)
[85.554536] [101/165] (913s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[85.675606] Starting subtest: basic-flip-before-cursor-varying-size
[86.675985] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.001s)
[86.794063] [102/165] (912s left) kms_dsc (dsc-basic)
[86.918449] Subtest dsc-basic: SKIP (0.000s)
[86.961877] [103/165] (912s left) kms_flip (basic-flip-vs-dpms)
[87.084179] Starting subtest: basic-flip-vs-dpms
[87.085675] Starting dynamic subtest: A-VGA1
[88.395792] Dynamic subtest A-VGA1: SUCCESS (1.307s)
[88.411972] Starting dynamic subtest: B-VGA1
[89.598774] Dynamic subtest B-VGA1: SUCCESS (1.206s)
[89.599855] Subtest basic-flip-vs-dpms: SUCCESS (2.515s)
[89.753680] [104/165] (909s left) kms_flip (basic-flip-vs-modeset)
[89.879073] Starting subtest: basic-flip-vs-modeset
[89.881062] Starting dynamic subtest: A-VGA1
[91.111798] Dynamic subtest A-VGA1: SUCCESS (1.233s)
[91.125120] Starting dynamic subtest: B-VGA1
[92.291842] Dynamic subtest B-VGA1: SUCCESS (1.179s)
[92.294800] Subtest basic-flip-vs-modeset: SUCCESS (2.413s)
[92.422011] [105/165] (906s left) kms_flip (basic-flip-vs-wf_vblank)
[92.543215] Starting subtest: basic-flip-vs-wf_vblank
[92.544331] Starting dynamic subtest: A-VGA1
[94.085065] Dynamic subtest A-VGA1: SUCCESS (1.541s)
[94.104910] Starting dynamic subtest: B-VGA1
[95.576283] Dynamic subtest B-VGA1: SUCCESS (1.491s)
[95.577455] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.034s)
[95.751839] [106/165] (903s left) kms_flip (basic-plain-flip)
[95.873751] Starting subtest: basic-plain-flip
[95.875041] Starting dynamic subtest: A-VGA1
[97.114978] Dynamic subtest A-VGA1: SUCCESS (1.237s)
[97.134243] Starting dynamic subtest: B-VGA1
[98.338088] Dynamic subtest B-VGA1: SUCCESS (1.223s)
[98.339157] Subtest basic-plain-flip: SUCCESS (2.462s)
[98.514660] [107/165] (900s left) kms_force_connector_basic (force-connector-state)
[98.668605] Starting subtest: force-connector-state
[98.828562] Subtest force-connector-state: SUCCESS (0.162s)
[99.101111] [108/165] (899s left) kms_force_connector_basic (force-edid)
[99.239837] Starting subtest: force-edid
[99.323382] Subtest force-edid: SUCCESS (0.082s)
[99.451423] [109/165] (899s left) kms_force_connector_basic (force-load-detect)
[99.608751] Starting subtest: force-load-detect
[99.784766] Subtest force-load-detect: SUCCESS (0.176s)
[100.003106] [110/165] (899s left) kms_force_connector_basic (prune-stale-modes)
[100.157414] Starting subtest: prune-stale-modes
[100.240466] Subtest prune-stale-modes: SUCCESS (0.083s)
[100.369907] [111/165] (898s left) kms_frontbuffer_tracking (basic)
[100.495976] Subtest basic: SKIP (0.000s)
[100.536694] [112/165] (898s left) kms_hdmi_inject (inject-audio)
[100.633479] Subtest inject-audio: SKIP (0.000s)
[100.672590] [113/165] (898s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[100.796018] Starting subtest: compare-crc-sanitycheck-xr24
[100.797575] Starting dynamic subtest: pipe-A-VGA-1
[101.083059] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.285s)
[101.098585] Starting dynamic subtest: pipe-B-VGA-1
[101.392565] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.310s)
[101.394845] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.598s)
[101.510014] [114/165] (897s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[101.636225] Starting subtest: compare-crc-sanitycheck-nv12
[101.638536] Starting dynamic subtest: pipe-A-VGA-1
[101.641374] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[101.651613] Starting dynamic subtest: pipe-B-VGA-1
[101.653773] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[101.655995] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[101.713456] [115/165] (897s left) kms_pipe_crc_basic (hang-read-crc)
[101.840946] Starting subtest: hang-read-crc
[101.842777] Starting dynamic subtest: pipe-A-VGA-1
[102.705936] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.866s)
[102.715733] Starting dynamic subtest: pipe-B-VGA-1
[103.571080] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.864s)
[103.574406] Subtest hang-read-crc: SUCCESS (1.733s)
[103.688339] [116/165] (895s left) kms_pipe_crc_basic (nonblocking-crc)
[103.813216] Starting subtest: nonblocking-crc
[103.814312] Starting dynamic subtest: pipe-A-VGA-1
[104.274624] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.461s)
[104.283886] Starting dynamic subtest: pipe-B-VGA-1
[104.767875] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.492s)
[104.771111] Subtest nonblocking-crc: SUCCESS (0.956s)
[104.881235] [117/165] (894s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[105.007350] Starting subtest: nonblocking-crc-frame-sequence
[105.008452] Starting dynamic subtest: pipe-A-VGA-1
[105.489927] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.481s)
[105.499260] Starting dynamic subtest: pipe-B-VGA-1
[105.959504] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.470s)
[105.962441] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.954s)
[106.073737] [118/165] (893s left) kms_pipe_crc_basic (read-crc)
[106.196887] Starting subtest: read-crc
[106.199915] Starting dynamic subtest: pipe-A-VGA-1
[106.579159] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.382s)
[106.597374] Starting dynamic subtest: pipe-B-VGA-1
[106.983257] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.402s)
[106.985269] Subtest read-crc: SUCCESS (0.787s)
[107.092532] [119/165] (892s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[107.214612] Starting subtest: read-crc-frame-sequence
[107.215860] Starting dynamic subtest: pipe-A-VGA-1
[107.616886] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.401s)
[107.632898] Starting dynamic subtest: pipe-B-VGA-1
[108.034468] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.416s)
[108.039311] Subtest read-crc-frame-sequence: SUCCESS (0.821s)
[108.149201] [120/165] (891s left) kms_pm_backlight (basic-brightness)
[108.275583] Subtest basic-brightness: SKIP (0.000s)
[108.316308] [121/165] (891s left) kms_pm_rpm (basic-pci-d3-state)
[119.601248] Subtest basic-pci-d3-state: SKIP (0.000s)
[119.621534] [122/165] (879s left) kms_pm_rpm (basic-rte)
[119.712802] Starting subtest: basic-rte
[130.902263] Subtest basic-rte: SKIP (11.174s)
[130.927321] [123/165] (868s left) kms_psr (psr-primary-page-flip)
[131.049305] Subtest psr-primary-page-flip: SKIP (0.000s)
[131.093597] [124/165] (868s left) kms_psr (psr-cursor-plane-move)
[131.220453] Subtest psr-cursor-plane-move: SKIP (0.000s)
[131.264793] [125/165] (868s left) kms_psr (psr-sprite-plane-onoff)
[131.385948] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[131.428516] [126/165] (868s left) kms_psr (psr-primary-mmap-gtt)
[131.553820] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[131.595386] [127/165] (867s left) kms_setmode (basic-clone-single-crtc)
[131.686911] Starting subtest: basic-clone-single-crtc
[131.690238] Subtest basic-clone-single-crtc: SKIP (0.000s)
[131.763223] [128/165] (867s left) i915_pm_rps (basic-api)
[131.856318] Subtest basic-api: SKIP (0.000s)
[131.896451] [129/165] (867s left) prime_self_import (basic-llseek-bad)
[131.985828] Starting subtest: basic-llseek-bad
[131.988648] Subtest basic-llseek-bad: SUCCESS (0.002s)
[132.064107] [130/165] (867s left) prime_self_import (basic-llseek-size)
[132.150320] Starting subtest: basic-llseek-size
[132.155708] Subtest basic-llseek-size: SUCCESS (0.006s)
[132.232530] [131/165] (867s left) prime_self_import (basic-with_fd_dup)
[132.321323] Starting subtest: basic-with_fd_dup
[132.325021] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[132.397908] [132/165] (867s left) prime_self_import (basic-with_one_bo)
[132.489383] Starting subtest: basic-with_one_bo
[132.491547] Subtest basic-with_one_bo: SUCCESS (0.004s)
[132.549998] [133/165] (867s left) prime_self_import (basic-with_one_bo_two_files)
[132.640868] Starting subtest: basic-with_one_bo_two_files
[132.643088] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[132.717380] [134/165] (866s left) prime_self_import (basic-with_two_bos)
[132.804307] Starting subtest: basic-with_two_bos
[132.806585] Subtest basic-with_two_bos: SUCCESS (0.004s)
[132.884601] [135/165] (866s left) prime_vgem (basic-fence-flip)
[132.994866] Starting subtest: basic-fence-flip
[133.397300] Subtest basic-fence-flip: SUCCESS (0.399s)
[133.488707] [136/165] (866s left) prime_vgem (basic-fence-mmap)
[133.598078] Starting subtest: basic-fence-mmap
[133.639328] Subtest basic-fence-mmap: SUCCESS (0.044s)
[133.720164] [137/165] (866s left) prime_vgem (basic-fence-read)
[133.815338] Starting subtest: basic-fence-read
[133.876085] Subtest basic-fence-read: SUCCESS (0.061s)
[133.954988] [138/165] (865s left) prime_vgem (basic-gtt)
[134.066094] Starting subtest: basic-gtt
[134.087293] Subtest basic-gtt: SUCCESS (0.021s)
[134.172124] [139/165] (865s left) prime_vgem (basic-read)
[134.267780] Starting subtest: basic-read
[134.293138] Subtest basic-read: SUCCESS (0.027s)
[134.372147] [140/165] (865s left) prime_vgem (basic-write)
[134.467076] Starting subtest: basic-write
[134.493744] Subtest basic-write: SUCCESS (0.029s)
[134.573906] [141/165] (865s left) vgem_basic (setversion)
[134.680763] Starting subtest: setversion
[134.683270] Subtest setversion: SUCCESS (0.000s)
[134.740768] [142/165] (865s left) vgem_basic (create)
[134.831854] Starting subtest: create
[134.833017] Subtest create: SUCCESS (0.000s)
[134.891674] [143/165] (864s left) vgem_basic (debugfs)
[134.981868] Starting subtest: debugfs
[134.983020] Subtest debugfs: SUCCESS (0.001s)
[135.040866] [144/165] (864s left) vgem_basic (dmabuf-export)
[135.134056] Starting subtest: dmabuf-export
[135.136163] Subtest dmabuf-export: SUCCESS (0.002s)
[135.209427] [145/165] (864s left) vgem_basic (dmabuf-fence)
[135.299858] Starting subtest: dmabuf-fence
[135.301048] Subtest dmabuf-fence: SUCCESS (0.001s)
[135.358592] [146/165] (864s left) vgem_basic (dmabuf-fence-before)
[135.450926] Starting subtest: dmabuf-fence-before
[135.452181] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[135.510441] [147/165] (864s left) vgem_basic (dmabuf-mmap)
[135.616925] Starting subtest: dmabuf-mmap
[135.638106] Subtest dmabuf-mmap: SUCCESS (0.022s)
[135.694272] [148/165] (864s left) vgem_basic (mmap)
[135.800665] Starting subtest: mmap
[135.814960] Subtest mmap: SUCCESS (0.016s)
[135.877596] [149/165] (864s left) vgem_basic (second-client)
[135.984487] Starting subtest: second-client
[136.018502] Subtest second-client: SUCCESS (0.033s)
[136.077611] [150/165] (863s left) vgem_basic (sysfs)
[136.170271] Starting subtest: sysfs
[136.171435] Subtest sysfs: SUCCESS (0.001s)
[136.229445] [151/165] (863s left) core_hotunplug (unbind-rebind)
[136.367862] Starting subtest: unbind-rebind
[139.116265] Subtest unbind-rebind: SUCCESS (2.748s)
[139.142923] [152/165] (860s left) vgem_basic (unload)
[139.237649] Starting subtest: unload
[168.106184] Subtest unload: SUCCESS (28.866s)
[168.212126] [153/165] (831s left) i915_module_load (reload)
[168.298801] Starting subtest: reload
[170.100830] Subtest reload: SUCCESS (1.800s)
[170.122252] [154/165] (830s left) gem_lmem_swapping (basic)
[170.227702] Subtest basic: SKIP (0.000s)
[170.262489] [155/165] (829s left) gem_lmem_swapping (parallel-random-engines)
[170.357552] Subtest parallel-random-engines: SKIP (0.000s)
[170.395536] [156/165] (829s left) gem_lmem_swapping (random-engines)
[170.551642] Subtest random-engines: SKIP (0.000s)
[170.603831] [157/165] (829s left) gem_lmem_swapping (verify-random)
[170.707769] Subtest verify-random: SKIP (0.000s)
[170.745498] [158/165] (829s left) i915_pm_rpm (module-reload)
[182.042279] Subtest module-reload: SKIP (0.000s)
[182.066724] [159/165] (818s left) i915_selftest (live)
[182.656459] Starting subtest: live
[182.657687] Starting dynamic subtest: sanitycheck
[183.340125] Dynamic subtest sanitycheck: SUCCESS (0.681s)
[183.348370] Starting dynamic subtest: uncore
[184.000881] Dynamic subtest uncore: SUCCESS (0.662s)
[184.009690] Starting dynamic subtest: workarounds
[184.643260] Dynamic subtest workarounds: SUCCESS (0.640s)
[184.651907] Starting dynamic subtest: gt_engines
[185.332193] Dynamic subtest gt_engines: SUCCESS (0.688s)
[185.340805] Starting dynamic subtest: gt_timelines
[188.163119] Dynamic subtest gt_timelines: SUCCESS (2.828s)
[188.171424] Starting dynamic subtest: gt_contexts
[188.795181] Dynamic subtest gt_contexts: SUCCESS (0.633s)
[188.803833] Starting dynamic subtest: gt_lrc
[189.439083] Dynamic subtest gt_lrc: SUCCESS (0.643s)
[189.448389] Starting dynamic subtest: gt_mocs
[190.089335] Dynamic subtest gt_mocs: SUCCESS (0.649s)
[190.098368] Starting dynamic subtest: gt_pm
[191.204194] Dynamic subtest gt_pm: SUCCESS (1.114s)
[191.212760] Starting dynamic subtest: gt_heartbeat
[191.857181] Dynamic subtest gt_heartbeat: SUCCESS (0.652s)
[191.865442] Starting dynamic subtest: gt_tlb
[192.513291] Dynamic subtest gt_tlb: SUCCESS (0.655s)
[192.522102] Starting dynamic subtest: requests
[195.742051] Dynamic subtest requests: SUCCESS (3.228s)
[195.750383] Starting dynamic subtest: migrate
[196.379160] Dynamic subtest migrate: SUCCESS (0.634s)
[196.387154] Starting dynamic subtest: active
[197.010218] Dynamic subtest active: SUCCESS (0.632s)
[197.018765] Starting dynamic subtest: objects
[197.996178] Dynamic subtest objects: SUCCESS (0.985s)
[198.004717] Starting dynamic subtest: mman
[202.878059] Dynamic subtest mman: SUCCESS (4.881s)
[202.887223] Starting dynamic subtest: dmabuf
[203.551646] Dynamic subtest dmabuf: SUCCESS (0.672s)
[203.560527] Starting dynamic subtest: vma
[204.190304] Dynamic subtest vma: SUCCESS (0.637s)
[204.199060] Starting dynamic subtest: coherency
[206.401250] Dynamic subtest coherency: SUCCESS (2.210s)
[206.410346] Starting dynamic subtest: gtt
[209.943462] Dynamic subtest gtt: SUCCESS (3.541s)
[209.951805] Starting dynamic subtest: gem
[210.655124] Dynamic subtest gem: SUCCESS (0.710s)
[210.663882] Starting dynamic subtest: evict
[211.304124] Dynamic subtest evict: SUCCESS (0.648s)
[211.313058] Starting dynamic subtest: hugepages
[211.949129] Dynamic subtest hugepages: SUCCESS (0.642s)
[211.957534] Starting dynamic subtest: gem_contexts
[212.584217] Dynamic subtest gem_contexts: SUCCESS (0.636s)
[212.593097] Starting dynamic subtest: client
[213.256210] Dynamic subtest client: SUCCESS (0.671s)
[213.265296] Starting dynamic subtest: gem_migrate
[213.911369] Dynamic subtest gem_migrate: SUCCESS (0.654s)
[213.919514] Starting dynamic subtest: reset
[214.895956] Dynamic subtest reset: SUCCESS (0.984s)
[214.904867] Starting dynamic subtest: memory_region
[215.542178] Dynamic subtest memory_region: SUCCESS (0.645s)
[215.550481] Starting dynamic subtest: hangcheck
[217.251137] Dynamic subtest hangcheck: SUCCESS (1.708s)
[217.259606] Starting dynamic subtest: execlists
[217.901829] Dynamic subtest execlists: SUCCESS (0.650s)
[217.911144] Starting dynamic subtest: ring_submission
[218.553110] Dynamic subtest ring_submission: SUCCESS (0.647s)
[218.561912] Starting dynamic subtest: perf
[219.200570] Dynamic subtest perf: SUCCESS (0.648s)
[219.208877] Starting dynamic subtest: slpc
[219.854213] Dynamic subtest slpc: SUCCESS (0.651s)
[219.862715] Starting dynamic subtest: guc
[220.506537] Dynamic subtest guc: SUCCESS (0.652s)
[220.515382] Starting dynamic subtest: guc_multi_lrc
[221.179664] Dynamic subtest guc_multi_lrc: SUCCESS (0.672s)
[221.188564] Starting dynamic subtest: guc_hang
[221.812410] Dynamic subtest guc_hang: SUCCESS (0.631s)
[221.821244] Starting dynamic subtest: late_gt_pm
[222.446141] Dynamic subtest late_gt_pm: SUCCESS (0.631s)
[222.447519] Subtest live: SUCCESS (39.788s)
[222.468974] [160/165] (777s left) dmabuf (all-tests)
[222.569159] Starting subtest: all-tests
[222.570269] Starting dynamic subtest: sanitycheck
[222.625044] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[222.636602] Starting dynamic subtest: dma_fence
[222.806962] Dynamic subtest dma_fence: SUCCESS (0.180s)
[222.822819] Starting dynamic subtest: dma_fence_chain
[240.151643] Dynamic subtest dma_fence_chain: SUCCESS (17.342s)
[240.163753] Starting dynamic subtest: dma_fence_unwrap
[240.209072] Dynamic subtest dma_fence_unwrap: SUCCESS (0.057s)
[240.220867] Starting dynamic subtest: dma_resv
[240.267706] Dynamic subtest dma_resv: SUCCESS (0.060s)
[240.269024] Subtest all-tests: SUCCESS (17.707s)
[240.288736] [161/165] (760s left) i915_suspend (basic-s2idle-without-i915)
[240.377776] Starting subtest: basic-s2idle-without-i915
[258.177742] Subtest basic-s2idle-without-i915: SUCCESS (17.798s)
[262.252139] [162/165] (742s left) i915_suspend (basic-s3-without-i915)
[262.346712] Starting subtest: basic-s3-without-i915
[279.068510] Subtest basic-s3-without-i915: SUCCESS (1.916s)
[282.147083] [163/165] (740s left) gem_exec_suspend (basic-s0)
[282.261222] Starting subtest: basic-S0
[282.262412] Starting dynamic subtest: smem
[298.992571] Dynamic subtest smem: SUCCESS (16.732s)
[298.993690] Subtest basic-S0: SUCCESS (16.734s)
[305.192330] [164/165] (723s left) gem_exec_suspend (basic-s3)
[305.304155] Starting subtest: basic-S3
[305.305278] Starting dynamic subtest: smem
[322.883075] Dynamic subtest smem: SUCCESS (1.856s)
[322.884325] Subtest basic-S3: SUCCESS (1.857s)
[326.069133] [165/165] (720s left) kms_pipe_crc_basic (suspend-read-crc)
[326.194704] Starting subtest: suspend-read-crc
[326.195955] Starting dynamic subtest: pipe-A-VGA-1
[343.893944] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.616s)
[343.908864] Starting dynamic subtest: pipe-B-VGA-1
[361.896123] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.632s)
[361.897513] Subtest suspend-read-crc: SUCCESS (3.252s)
[368.006057] Closing watchdogs
Done.