[82.037844] Initializing watchdogs
[82.038539]   /dev/watchdog0
[82.061739] [001/160] (960s left) i915_module_load (load)
[82.476945] Starting subtest: load
[87.610131] Subtest load: SUCCESS (5.123s)
[87.732691] [002/160] (954s left) core_auth (basic-auth)
[88.594417] Starting subtest: basic-auth
[88.603465] Subtest basic-auth: SUCCESS (0.005s)
[88.736475] [003/160] (953s left) debugfs_test (read_all_entries)
[89.180175] Starting subtest: read_all_entries
[89.344280] Subtest read_all_entries: SUCCESS (0.167s)
[89.530417] [004/160] (953s left) debugfs_test (basic-hwmon)
[89.941779] Starting subtest: basic-hwmon
[89.949561] Subtest basic-hwmon: SKIP (0.000s)
[90.120745] [005/160] (952s left) fbdev (eof)
[90.547490] Starting subtest: eof
[90.551671] Subtest eof: SUCCESS (0.004s)
[90.661255] [006/160] (952s left) fbdev (info)
[91.046785] Starting subtest: info
[91.051463] Subtest info: SUCCESS (0.000s)
[91.163521] [007/160] (951s left) fbdev (nullptr)
[91.573291] Starting subtest: nullptr
[91.577584] Subtest nullptr: SUCCESS (0.000s)
[91.680195] [008/160] (951s left) fbdev (read)
[92.127764] Starting subtest: read
[92.407287] Subtest read: SUCCESS (0.282s)
[92.512948] [009/160] (950s left) fbdev (write)
[92.925792] Starting subtest: write
[93.087654] Subtest write: SUCCESS (0.162s)
[93.199604] [010/160] (950s left) gem_basic (bad-close)
[93.592347] Starting subtest: bad-close
[93.598248] Subtest bad-close: SUCCESS (0.000s)
[93.717979] [011/160] (949s left) gem_basic (create-close)
[94.110806] Starting subtest: create-close
[94.118565] Subtest create-close: SUCCESS (0.001s)
[94.248939] [012/160] (949s left) gem_basic (create-fd-close)
[94.645761] Starting subtest: create-fd-close
[94.652286] Subtest create-fd-close: SUCCESS (0.001s)
[94.784741] [013/160] (948s left) gem_busy (busy@all-engines)
[95.248333] Starting subtest: busy
[95.252566] Starting dynamic subtest: all-engines
[95.356658] Dynamic subtest all-engines: SUCCESS (0.110s)
[95.360380] Subtest busy: SUCCESS (0.113s)
[95.838747] [014/160] (947s left) gem_close_race (basic-process)
[96.303383] Starting subtest: basic-process
[96.482429] Subtest basic-process: SUCCESS (0.179s)
[96.763595] [015/160] (946s left) gem_close_race (basic-threads)
[97.237324] Starting subtest: basic-threads
[98.631612] Subtest basic-threads: SUCCESS (1.396s)
[98.908329] [016/160] (944s left) gem_ctx_create (basic)
[99.320859] Subtest basic: SKIP (0.000s)
[99.410946] [017/160] (944s left) gem_ctx_create (basic-files)
[99.865143] Subtest basic-files: SKIP (0.000s)
[99.964217] [018/160] (943s left) gem_ctx_exec (basic)
[100.414637] Subtest basic: SKIP (0.000s)
[100.547788] [019/160] (943s left) gem_exec_basic (basic)
[100.996298] Starting subtest: basic
[101.000293] Starting dynamic subtest: rcs0-smem
[101.003592] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[101.006673] Subtest basic: SUCCESS (0.009s)
[101.281406] [020/160] (942s left) gem_exec_create (basic)
[101.798615] Starting subtest: basic
[101.804393] Starting dynamic subtest: smem
[103.922520] Dynamic subtest smem: SUCCESS (2.126s)
[103.925613] Subtest basic: SUCCESS (2.129s)
[104.196129] [021/160] (939s left) gem_exec_fence (basic-busy)
[104.836459] Starting subtest: basic-busy
[104.840494] Starting dynamic subtest: rcs0
[104.881552] Dynamic subtest rcs0: SUCCESS (0.043s)
[104.884634] Subtest basic-busy: SUCCESS (0.047s)
[105.750208] [022/160] (938s left) gem_exec_fence (basic-wait)
[106.388375] Starting subtest: basic-wait
[106.392932] Starting dynamic subtest: rcs0
[106.423630] Dynamic subtest rcs0: SUCCESS (0.033s)
[106.427167] Subtest basic-wait: SUCCESS (0.036s)
[107.100215] [023/160] (937s left) gem_exec_fence (basic-await)
[107.740337] Starting subtest: basic-await
[107.744718] Starting dynamic subtest: rcs0
[107.852816] Dynamic subtest rcs0: SUCCESS (0.110s)
[107.856295] Subtest basic-await: SUCCESS (0.113s)
[108.537839] [024/160] (935s left) gem_exec_fence (nb-await)
[109.187801] Starting subtest: nb-await
[109.191269] Starting dynamic subtest: rcs0
[109.255537] Dynamic subtest rcs0: SUCCESS (0.065s)
[109.258635] Subtest nb-await: SUCCESS (0.068s)
[109.938210] [025/160] (934s left) gem_exec_gttfill (basic)
[110.392852] Starting subtest: basic
[123.366364] Subtest basic: SUCCESS (12.966s)
[123.671589] [026/160] (920s left) gem_exec_parallel (engines)
[124.521798] Starting subtest: engines
[124.525477] Starting dynamic subtest: basic
[128.169490] Dynamic subtest basic: SUCCESS (3.643s)
[128.213213] Starting dynamic subtest: contexts
[128.219259] Dynamic subtest contexts: SKIP (0.003s)
[128.252234] Starting dynamic subtest: fds
[128.257809] Dynamic subtest fds: SKIP (0.004s)
[128.291156] Starting dynamic subtest: userptr
[131.746552] Dynamic subtest userptr: SUCCESS (3.565s)
[131.750359] Subtest engines: SUCCESS (7.222s)
[132.020481] [027/160] (912s left) gem_exec_store (basic)
[132.481684] Starting subtest: basic
[132.544183] Subtest basic: SUCCESS (0.065s)
[132.828355] [028/160] (911s left) gem_flink_basic (bad-flink)
[133.319363] Starting subtest: bad-flink
[133.323743] Subtest bad-flink: SUCCESS (0.000s)
[133.451544] [029/160] (911s left) gem_flink_basic (bad-open)
[133.855547] Starting subtest: bad-open
[133.859624] Subtest bad-open: SUCCESS (0.000s)
[133.981282] [030/160] (910s left) gem_flink_basic (basic)
[134.387487] Starting subtest: basic
[134.392103] Subtest basic: SUCCESS (0.001s)
[134.515544] [031/160] (910s left) gem_flink_basic (double-flink)
[134.917935] Starting subtest: double-flink
[134.921373] Subtest double-flink: SUCCESS (0.001s)
[135.054738] [032/160] (909s left) gem_flink_basic (flink-lifetime)
[135.446509] Starting subtest: flink-lifetime
[135.450836] Subtest flink-lifetime: SUCCESS (0.006s)
[135.583757] [033/160] (909s left) gem_huc_copy (huc-copy)
[135.998699] Subtest huc-copy: SKIP (0.000s)
[136.094357] [034/160] (909s left) gem_linear_blits (basic)
[136.952692] Starting subtest: basic
[137.010611] Subtest basic: SUCCESS (0.062s)
[137.241327] [035/160] (907s left) gem_mmap (basic)
[137.938198] Starting subtest: basic
[137.952670] Subtest basic: SUCCESS (0.003s)
[138.092152] [036/160] (907s left) gem_mmap_gtt (basic)
[138.501719] Starting subtest: basic
[138.506468] Subtest basic: SUCCESS (0.004s)
[138.627232] [037/160] (906s left) gem_render_linear_blits (basic)
[139.040791] Starting subtest: basic
[139.174524] Subtest basic: SUCCESS (0.133s)
[139.293434] [038/160] (906s left) gem_render_tiled_blits (basic)
[139.701579] Starting subtest: basic
[139.839547] Subtest basic: SUCCESS (0.135s)
[139.962416] [039/160] (905s left) gem_ringfill (basic-all)
[140.418520] Starting subtest: basic-all
[141.613589] Subtest basic-all: SUCCESS (1.193s)
[141.759210] [040/160] (903s left) gem_softpin (allocator-basic)
[142.183316] Subtest allocator-basic: SKIP (0.000s)
[142.307984] [041/160] (903s left) gem_softpin (allocator-basic-reserve)
[142.714676] Subtest allocator-basic-reserve: SKIP (0.000s)
[142.842496] [042/160] (902s left) gem_softpin (safe-alignment)
[143.248369] Starting subtest: safe-alignment
[143.274683] Subtest safe-alignment: SUCCESS (0.032s)
[143.426470] [043/160] (902s left) gem_sync (basic-all)
[143.884106] Starting subtest: basic-all
[146.009682] Subtest basic-all: SUCCESS (2.125s)
[146.285547] [044/160] (899s left) gem_sync (basic-each)
[146.738421] Starting subtest: basic-each
[148.863246] Subtest basic-each: SUCCESS (2.123s)
[149.135729] [045/160] (896s left) gem_tiled_blits (basic)
[149.821610] Starting subtest: basic
[149.920255] Subtest basic: SUCCESS (0.099s)
[150.159625] [046/160] (896s left) gem_tiled_fence_blits (basic)
[151.188120] Starting subtest: basic
[151.261532] Subtest basic: SUCCESS (0.073s)
[151.474269] [047/160] (894s left) gem_tiled_pread_basic
[154.189652] [048/160] (892s left) gem_wait (busy@all-engines)
[154.683167] Starting subtest: busy
[154.687478] Starting dynamic subtest: all-engines
[155.218177] Dynamic subtest all-engines: SUCCESS (0.535s)
[155.221358] Subtest busy: SUCCESS (0.538s)
[155.627594] [049/160] (890s left) gem_wait (wait@all-engines)
[156.111452] Starting subtest: wait
[156.115770] Starting dynamic subtest: all-engines
[157.147227] Dynamic subtest all-engines: SUCCESS (1.038s)
[157.150547] Subtest wait: SUCCESS (1.041s)
[157.544855] [050/160] (888s left) i915_getparams_basic (basic-eu-total)
[157.953393] Starting subtest: basic-eu-total
[157.960541] Subtest basic-eu-total: SUCCESS (0.000s)
[158.092763] [051/160] (888s left) i915_getparams_basic (basic-subslice-total)
[158.483267] Starting subtest: basic-subslice-total
[158.489223] Subtest basic-subslice-total: SUCCESS (0.000s)
[158.630466] [052/160] (888s left) i915_hangman (error-state-basic)
[159.060171] Starting subtest: error-state-basic
[159.387444] Subtest error-state-basic: SUCCESS (0.332s)
[159.514499] [053/160] (887s left) i915_pciid
[160.042148] [054/160] (886s left) kms_addfb_basic (addfb25-4-tiled)
[160.542618] Starting subtest: addfb25-4-tiled
[160.546576] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[160.691294] [055/160] (886s left) kms_addfb_basic (addfb25-bad-modifier)
[161.103818] Starting subtest: addfb25-bad-modifier
[161.108188] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[161.312259] [056/160] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[161.708328] Starting subtest: addfb25-framebuffer-vs-set-tiling
[161.712255] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[161.895496] [057/160] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[162.293378] Starting subtest: addfb25-modifier-no-flag
[162.296468] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[162.492157] [058/160] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[162.917312] Starting subtest: addfb25-x-tiled-legacy
[162.921638] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[163.113207] [059/160] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[163.526560] Starting subtest: addfb25-x-tiled-mismatch-legacy
[163.530411] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[163.713773] [060/160] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[164.161284] Starting subtest: addfb25-yf-tiled-legacy
[164.165918] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[164.299127] [061/160] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[164.745753] Starting subtest: addfb25-y-tiled-legacy
[164.749397] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[164.900862] [062/160] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[165.364130] Starting subtest: addfb25-y-tiled-small-legacy
[165.371109] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[165.519272] [063/160] (882s left) kms_addfb_basic (bad-pitch-0)
[165.928853] Starting subtest: bad-pitch-0
[165.932976] Subtest bad-pitch-0: SUCCESS (0.000s)
[166.120665] [064/160] (881s left) kms_addfb_basic (bad-pitch-1024)
[166.527204] Starting subtest: bad-pitch-1024
[166.530351] Subtest bad-pitch-1024: SUCCESS (0.000s)
[166.763696] [065/160] (881s left) kms_addfb_basic (bad-pitch-128)
[167.159667] Starting subtest: bad-pitch-128
[167.163550] Subtest bad-pitch-128: SUCCESS (0.000s)
[167.409163] [066/160] (880s left) kms_addfb_basic (bad-pitch-256)
[167.821414] Starting subtest: bad-pitch-256
[167.825679] Subtest bad-pitch-256: SUCCESS (0.000s)
[168.003575] [067/160] (880s left) kms_addfb_basic (bad-pitch-32)
[168.412729] Starting subtest: bad-pitch-32
[168.417141] Subtest bad-pitch-32: SUCCESS (0.000s)
[168.618511] [068/160] (879s left) kms_addfb_basic (bad-pitch-63)
[169.029634] Starting subtest: bad-pitch-63
[169.033800] Subtest bad-pitch-63: SUCCESS (0.000s)
[169.236985] [069/160] (878s left) kms_addfb_basic (bad-pitch-65536)
[169.636116] Starting subtest: bad-pitch-65536
[169.639805] Subtest bad-pitch-65536: SUCCESS (0.001s)
[169.820677] [070/160] (878s left) kms_addfb_basic (bad-pitch-999)
[170.215217] Starting subtest: bad-pitch-999
[170.219466] Subtest bad-pitch-999: SUCCESS (0.000s)
[170.437365] [071/160] (877s left) kms_addfb_basic (basic)
[170.839465] Starting subtest: basic
[170.843738] Subtest basic: SUCCESS (0.000s)
[171.038159] [072/160] (877s left) kms_addfb_basic (basic-x-tiled-legacy)
[171.445269] Starting subtest: basic-x-tiled-legacy
[171.449167] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[171.626181] [073/160] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[172.041701] Starting subtest: basic-y-tiled-legacy
[172.045576] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[172.227766] [074/160] (876s left) kms_addfb_basic (bo-too-small)
[172.686783] Starting subtest: bo-too-small
[172.690875] Subtest bo-too-small: SUCCESS (0.002s)
[172.827978] [075/160] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[173.285121] Starting subtest: bo-too-small-due-to-tiling
[173.289216] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[173.438308] [076/160] (875s left) kms_addfb_basic (clobberred-modifier)
[173.842550] Starting subtest: clobberred-modifier
[173.847317] Subtest clobberred-modifier: SUCCESS (0.001s)
[174.057168] [077/160] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[174.471667] Starting subtest: framebuffer-vs-set-tiling
[174.475756] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[174.664091] [078/160] (874s left) kms_addfb_basic (invalid-get-prop)
[175.067794] Starting subtest: invalid-get-prop
[175.071599] Subtest invalid-get-prop: SUCCESS (0.000s)
[175.245473] [079/160] (873s left) kms_addfb_basic (invalid-get-prop-any)
[175.658290] Starting subtest: invalid-get-prop-any
[175.662741] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[175.869386] [080/160] (873s left) kms_addfb_basic (invalid-set-prop)
[176.287316] Starting subtest: invalid-set-prop
[176.291717] Subtest invalid-set-prop: SUCCESS (0.000s)
[176.562402] [081/160] (872s left) kms_addfb_basic (invalid-set-prop-any)
[176.995315] Starting subtest: invalid-set-prop-any
[177.000679] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[177.225320] [082/160] (872s left) kms_addfb_basic (no-handle)
[177.679543] Starting subtest: no-handle
[177.683252] Subtest no-handle: SUCCESS (0.000s)
[177.926651] [083/160] (871s left) kms_addfb_basic (size-max)
[178.404704] Starting subtest: size-max
[178.409748] Subtest size-max: SUCCESS (0.001s)
[178.544879] [084/160] (871s left) kms_addfb_basic (small-bo)
[178.988639] Starting subtest: small-bo
[178.993606] Subtest small-bo: SUCCESS (0.000s)
[179.129577] [085/160] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[179.526870] Starting subtest: tile-pitch-mismatch
[179.531272] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[179.718464] [086/160] (870s left) kms_addfb_basic (too-high)
[180.164303] Starting subtest: too-high
[180.168830] Subtest too-high: SUCCESS (0.005s)
[180.315251] [087/160] (869s left) kms_addfb_basic (too-wide)
[180.763605] Starting subtest: too-wide
[180.767732] Subtest too-wide: SUCCESS (0.000s)
[180.911166] [088/160] (869s left) kms_addfb_basic (unused-handle)
[181.309751] Starting subtest: unused-handle
[181.314493] Subtest unused-handle: SUCCESS (0.000s)
[181.500535] [089/160] (868s left) kms_addfb_basic (unused-modifier)
[181.908860] Starting subtest: unused-modifier
[181.912713] Subtest unused-modifier: SUCCESS (0.000s)
[182.095981] [090/160] (868s left) kms_addfb_basic (unused-offsets)
[182.493226] Starting subtest: unused-offsets
[182.497637] Subtest unused-offsets: SUCCESS (0.000s)
[182.729542] [091/160] (867s left) kms_addfb_basic (unused-pitches)
[183.174632] Starting subtest: unused-pitches
[183.179200] Subtest unused-pitches: SUCCESS (0.000s)
[183.393912] [092/160] (866s left) kms_busy (basic)
[183.860600] Starting subtest: basic
[183.863726] Starting dynamic subtest: flip
[185.268079] Dynamic subtest flip: SUCCESS (1.400s)
[185.313347] Starting dynamic subtest: modeset
[185.320228] Dynamic subtest modeset: SKIP (0.000s)
[185.323830] Subtest basic: SUCCESS (1.408s)
[185.532927] [093/160] (864s left) kms_prop_blob (basic)
[185.932549] Starting subtest: basic
[185.936175] Subtest basic: SUCCESS (0.000s)
[186.070792] [094/160] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[186.523897] Starting subtest: basic-busy-flip-before-cursor-atomic
[186.536594] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.014s)
[186.675601] [095/160] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[187.117612] Starting subtest: basic-busy-flip-before-cursor-legacy
[188.375970] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.254s)
[188.652671] [096/160] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[189.117536] Starting subtest: basic-flip-after-cursor-atomic
[189.123970] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[189.279765] [097/160] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[189.718441] Starting subtest: basic-flip-after-cursor-legacy
[190.976169] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.252s)
[191.237951] [098/160] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[191.663177] Starting subtest: basic-flip-after-cursor-varying-size
[192.926198] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.259s)
[193.256703] [099/160] (857s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[193.791624] Starting subtest: basic-flip-before-cursor-atomic
[193.800861] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[193.977876] [100/160] (857s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[194.461253] Starting subtest: basic-flip-before-cursor-legacy
[195.716310] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.254s)
[196.009669] [101/160] (855s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[196.461274] Starting subtest: basic-flip-before-cursor-varying-size
[197.718638] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.256s)
[197.994334] [102/160] (853s left) kms_dsc (dsc-basic)
[198.447123] Subtest dsc-basic: SKIP (0.000s)
[198.551177] [103/160] (852s left) kms_flip (basic-flip-vs-dpms)
[198.995439] Starting subtest: basic-flip-vs-dpms
[198.999812] Starting dynamic subtest: A-VGA1
[200.744708] Dynamic subtest A-VGA1: SUCCESS (1.742s)
[200.786432] Starting dynamic subtest: B-VGA1
[202.101494] Dynamic subtest B-VGA1: SUCCESS (1.354s)
[202.105436] Subtest basic-flip-vs-dpms: SUCCESS (3.104s)
[202.512115] [104/160] (848s left) kms_flip (basic-flip-vs-modeset)
[202.969610] Starting subtest: basic-flip-vs-modeset
[202.973772] Starting dynamic subtest: A-VGA1
[204.555349] Dynamic subtest A-VGA1: SUCCESS (1.582s)
[204.603767] Starting dynamic subtest: B-VGA1
[205.856686] Dynamic subtest B-VGA1: SUCCESS (1.295s)
[205.860699] Subtest basic-flip-vs-modeset: SUCCESS (2.885s)
[206.209485] [105/160] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[206.649421] Starting subtest: basic-flip-vs-wf_vblank
[206.653586] Starting dynamic subtest: A-VGA1
[208.528571] Dynamic subtest A-VGA1: SUCCESS (1.873s)
[208.574485] Starting dynamic subtest: B-VGA1
[210.196316] Dynamic subtest B-VGA1: SUCCESS (1.668s)
[210.204899] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.547s)
[210.620929] [106/160] (841s left) kms_flip (basic-plain-flip)
[211.073222] Starting subtest: basic-plain-flip
[211.077590] Starting dynamic subtest: A-VGA1
[212.666363] Dynamic subtest A-VGA1: SUCCESS (1.589s)
[212.705698] Starting dynamic subtest: B-VGA1
[214.079490] Dynamic subtest B-VGA1: SUCCESS (1.409s)
[214.083434] Subtest basic-plain-flip: SUCCESS (3.003s)
[214.562330] [107/160] (837s left) kms_force_connector_basic (force-connector-state)
[215.053510] Starting subtest: force-connector-state
[215.318520] Subtest force-connector-state: SUCCESS (0.257s)
[215.730740] [108/160] (836s left) kms_force_connector_basic (force-edid)
[216.189437] Starting subtest: force-edid
[216.269448] Subtest force-edid: SUCCESS (0.084s)
[216.514719] [109/160] (835s left) kms_force_connector_basic (force-load-detect)
[216.977767] Starting subtest: force-load-detect
[217.382090] Subtest force-load-detect: SUCCESS (0.409s)
[217.754753] [110/160] (834s left) kms_force_connector_basic (prune-stale-modes)
[218.245738] Starting subtest: prune-stale-modes
[218.330513] Subtest prune-stale-modes: SUCCESS (0.082s)
[218.566500] [111/160] (833s left) kms_frontbuffer_tracking (basic)
[219.027348] Subtest basic: SKIP (0.000s)
[219.157184] [112/160] (833s left) kms_hdmi_inject (inject-audio)
[219.573799] Subtest inject-audio: SKIP (0.000s)
[219.688410] [113/160] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[220.132719] Starting subtest: compare-crc-sanitycheck-xr24
[220.137506] Starting dynamic subtest: pipe-A-VGA-1
[220.504484] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.366s)
[220.553339] Starting dynamic subtest: pipe-B-VGA-1
[220.979667] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.469s)
[220.985780] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.847s)
[221.258785] [114/160] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[221.688989] Starting subtest: compare-crc-sanitycheck-nv12
[221.695114] Starting dynamic subtest: pipe-A-VGA-1
[221.703160] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[221.741440] Starting dynamic subtest: pipe-B-VGA-1
[221.747099] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[221.754534] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[221.844759] [115/160] (830s left) kms_pipe_crc_basic (hang-read-crc)
[222.287225] Starting subtest: hang-read-crc
[222.291869] Starting dynamic subtest: pipe-A-VGA-1
[223.490115] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.199s)
[223.527303] Starting dynamic subtest: pipe-B-VGA-1
[224.802728] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.305s)
[224.807627] Subtest hang-read-crc: SUCCESS (2.515s)
[225.076832] [116/160] (827s left) kms_pipe_crc_basic (nonblocking-crc)
[225.517709] Starting subtest: nonblocking-crc
[225.522407] Starting dynamic subtest: pipe-A-VGA-1
[226.067957] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.548s)
[226.122768] Starting dynamic subtest: pipe-B-VGA-1
[226.730713] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.656s)
[226.735357] Subtest nonblocking-crc: SUCCESS (1.216s)
[226.996584] [117/160] (825s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[227.442511] Starting subtest: nonblocking-crc-frame-sequence
[227.446361] Starting dynamic subtest: pipe-A-VGA-1
[228.011328] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.563s)
[228.060713] Starting dynamic subtest: pipe-B-VGA-1
[228.672735] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.655s)
[228.676888] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.231s)
[228.925191] [118/160] (823s left) kms_pipe_crc_basic (read-crc)
[229.365773] Starting subtest: read-crc
[229.370252] Starting dynamic subtest: pipe-A-VGA-1
[229.848759] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.479s)
[229.891565] Starting dynamic subtest: pipe-B-VGA-1
[230.481870] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.624s)
[230.486292] Subtest read-crc: SUCCESS (1.116s)
[230.737823] [119/160] (822s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[231.194670] Starting subtest: read-crc-frame-sequence
[231.199314] Starting dynamic subtest: pipe-A-VGA-1
[231.712208] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.516s)
[231.782638] Starting dynamic subtest: pipe-B-VGA-1
[232.321837] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.601s)
[232.326345] Subtest read-crc-frame-sequence: SUCCESS (1.130s)
[232.580351] [120/160] (820s left) kms_pm_backlight (basic-brightness)
[233.037446] Subtest basic-brightness: SKIP (0.000s)
[233.153511] [121/160] (819s left) kms_pm_rpm (basic-pci-d3-state)
[245.034474] Subtest basic-pci-d3-state: SKIP (0.000s)
[245.142649] [122/160] (808s left) kms_pm_rpm (basic-rte)
[245.529957] Starting subtest: basic-rte
[257.012324] Subtest basic-rte: SKIP (11.464s)
[257.124270] [123/160] (796s left) kms_psr (psr-primary-page-flip)
[257.588141] Subtest psr-primary-page-flip: SKIP (0.000s)
[257.687185] [124/160] (795s left) kms_psr (psr-cursor-plane-move)
[258.127304] Subtest psr-cursor-plane-move: SKIP (0.000s)
[258.242678] [125/160] (795s left) kms_psr (psr-sprite-plane-onoff)
[258.697137] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[258.813909] [126/160] (794s left) kms_psr (psr-primary-mmap-gtt)
[259.265609] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[259.375636] [127/160] (794s left) kms_setmode (basic-clone-single-crtc)
[259.773229] Starting subtest: basic-clone-single-crtc
[259.782541] Subtest basic-clone-single-crtc: SKIP (0.000s)
[259.920343] [128/160] (793s left) i915_pm_rps (basic-api)
[260.325899] Subtest basic-api: SKIP (0.000s)
[260.442088] [129/160] (793s left) prime_self_import (basic-llseek-bad)
[260.833300] Starting subtest: basic-llseek-bad
[260.841823] Subtest basic-llseek-bad: SUCCESS (0.012s)
[260.983273] [130/160] (792s left) prime_self_import (basic-llseek-size)
[261.370655] Starting subtest: basic-llseek-size
[261.387950] Subtest basic-llseek-size: SUCCESS (0.016s)
[261.536707] [131/160] (792s left) prime_self_import (basic-with_fd_dup)
[261.934244] Starting subtest: basic-with_fd_dup
[261.950597] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[262.104340] [132/160] (791s left) prime_self_import (basic-with_one_bo)
[262.486447] Starting subtest: basic-with_one_bo
[262.506403] Subtest basic-with_one_bo: SUCCESS (0.020s)
[262.659999] [133/160] (791s left) prime_self_import (basic-with_one_bo_two_files)
[263.044751] Starting subtest: basic-with_one_bo_two_files
[263.062660] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[263.188333] [134/160] (791s left) prime_self_import (basic-with_two_bos)
[263.573496] Starting subtest: basic-with_two_bos
[263.589217] Subtest basic-with_two_bos: SUCCESS (0.017s)
[263.739531] [135/160] (790s left) prime_vgem (basic-fence-flip)
[264.172242] Starting subtest: basic-fence-flip
[264.774547] Subtest basic-fence-flip: SUCCESS (0.597s)
[264.942852] [136/160] (789s left) prime_vgem (basic-fence-mmap)
[265.358661] Starting subtest: basic-fence-mmap
[265.532558] Subtest basic-fence-mmap: SUCCESS (0.178s)
[265.676475] [137/160] (788s left) prime_vgem (basic-fence-read)
[266.089478] Starting subtest: basic-fence-read
[266.347252] Subtest basic-fence-read: SUCCESS (0.258s)
[266.494295] [138/160] (788s left) prime_vgem (basic-gtt)
[266.924182] Starting subtest: basic-gtt
[266.998651] Subtest basic-gtt: SUCCESS (0.074s)
[267.141463] [139/160] (787s left) prime_vgem (basic-read)
[267.576849] Starting subtest: basic-read
[267.689247] Subtest basic-read: SUCCESS (0.112s)
[267.859681] [140/160] (786s left) prime_vgem (basic-write)
[268.297295] Starting subtest: basic-write
[268.428393] Subtest basic-write: SUCCESS (0.133s)
[268.576401] [141/160] (786s left) vgem_basic (setversion)
[268.976772] Starting subtest: setversion
[268.983564] Subtest setversion: SUCCESS (0.000s)
[269.100584] [142/160] (785s left) vgem_basic (create)
[269.510390] Starting subtest: create
[269.513764] Subtest create: SUCCESS (0.002s)
[269.626452] [143/160] (785s left) vgem_basic (debugfs)
[270.031716] Starting subtest: debugfs
[270.035851] Subtest debugfs: SUCCESS (0.003s)
[270.147606] [144/160] (784s left) vgem_basic (dmabuf-export)
[270.561772] Starting subtest: dmabuf-export
[270.571220] Subtest dmabuf-export: SUCCESS (0.011s)
[270.713143] [145/160] (784s left) vgem_basic (dmabuf-fence)
[271.111907] Starting subtest: dmabuf-fence
[271.116356] Subtest dmabuf-fence: SUCCESS (0.005s)
[271.231664] [146/160] (784s left) vgem_basic (dmabuf-fence-before)
[271.628772] Starting subtest: dmabuf-fence-before
[271.632768] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[271.746277] [147/160] (783s left) vgem_basic (dmabuf-mmap)
[272.146752] Starting subtest: dmabuf-mmap
[272.227214] Subtest dmabuf-mmap: SUCCESS (0.082s)
[272.345449] [148/160] (783s left) vgem_basic (mmap)
[272.750869] Starting subtest: mmap
[272.801721] Subtest mmap: SUCCESS (0.056s)
[272.931603] [149/160] (782s left) vgem_basic (second-client)
[273.331297] Starting subtest: second-client
[273.364663] Subtest second-client: SUCCESS (0.033s)
[273.483503] [150/160] (782s left) vgem_basic (sysfs)
[273.902641] Starting subtest: sysfs
[273.906724] Subtest sysfs: SUCCESS (0.006s)
[274.014921] [151/160] (781s left) core_hotunplug (unbind-rebind)
[274.546132] Starting subtest: unbind-rebind
[278.899163] Subtest unbind-rebind: SUCCESS (4.338s)
[279.028609] [152/160] (776s left) vgem_basic (unload)
[279.452851] Starting subtest: unload
[308.754829] Subtest unload: SUCCESS (29.286s)
[309.024360] [153/160] (746s left) i915_module_load (reload)
[309.414253] Starting subtest: reload
[314.399600] Subtest reload: SUCCESS (4.985s)
[314.583552] [154/160] (741s left) gem_lmem_swapping (basic)
[315.350436] Subtest basic: SKIP (0.000s)
[315.486212] [155/160] (740s left) gem_lmem_swapping (parallel-random-engines)
[315.908350] Subtest parallel-random-engines: SKIP (0.000s)
[316.004967] [156/160] (740s left) gem_lmem_swapping (random-engines)
[316.421691] Subtest random-engines: SKIP (0.000s)
[316.521681] [157/160] (739s left) gem_lmem_swapping (verify-random)
[316.932308] Subtest verify-random: SKIP (0.000s)
[317.039747] [158/160] (739s left) i915_pm_rpm (module-reload)
[328.914257] Subtest module-reload: SKIP (0.000s)
[329.022757] [159/160] (727s left) i915_selftest (live)
[331.152234] Starting subtest: live
[331.156351] Starting dynamic subtest: sanitycheck
[333.482795] Dynamic subtest sanitycheck: SUCCESS (2.328s)
[333.512280] Starting dynamic subtest: uncore
[335.613725] Dynamic subtest uncore: SUCCESS (2.127s)
[335.651726] Starting dynamic subtest: workarounds
[337.725828] Dynamic subtest workarounds: SUCCESS (2.108s)
[337.755117] Starting dynamic subtest: gt_engines
[339.849595] Dynamic subtest gt_engines: SUCCESS (2.119s)
[339.887108] Starting dynamic subtest: gt_timelines
[349.832276] Dynamic subtest gt_timelines: SUCCESS (9.974s)
[349.862529] Starting dynamic subtest: gt_contexts
[351.966543] Dynamic subtest gt_contexts: SUCCESS (2.129s)
[352.004233] Starting dynamic subtest: gt_lrc
[354.078294] Dynamic subtest gt_lrc: SUCCESS (2.109s)
[354.108937] Starting dynamic subtest: gt_mocs
[356.174516] Dynamic subtest gt_mocs: SUCCESS (2.092s)
[356.212833] Starting dynamic subtest: gt_pm
[358.714357] Dynamic subtest gt_pm: SUCCESS (2.533s)
[358.752249] Starting dynamic subtest: gt_heartbeat
[360.860800] Dynamic subtest gt_heartbeat: SUCCESS (2.142s)
[360.890229] Starting dynamic subtest: gt_tlb
[362.957385] Dynamic subtest gt_tlb: SUCCESS (2.091s)
[362.995605] Starting dynamic subtest: requests
[367.697246] Dynamic subtest requests: SUCCESS (4.735s)
[367.729314] Starting dynamic subtest: migrate
[369.789454] Dynamic subtest migrate: SUCCESS (2.088s)
[369.819515] Starting dynamic subtest: active
[371.944175] Dynamic subtest active: SUCCESS (2.151s)
[371.973377] Starting dynamic subtest: objects
[375.079189] Dynamic subtest objects: SUCCESS (3.131s)
[375.109465] Starting dynamic subtest: mman
[386.691658] Dynamic subtest mman: SUCCESS (11.603s)
[386.729935] Starting dynamic subtest: dmabuf
[388.922295] Dynamic subtest dmabuf: SUCCESS (2.226s)
[388.952600] Starting dynamic subtest: vma
[391.096963] Dynamic subtest vma: SUCCESS (2.170s)
[391.126989] Starting dynamic subtest: coherency
[399.912704] Dynamic subtest coherency: SUCCESS (8.807s)
[399.946180] Starting dynamic subtest: gtt
[404.990605] Dynamic subtest gtt: SUCCESS (5.070s)
[405.028251] Starting dynamic subtest: gem
[407.170105] Dynamic subtest gem: SUCCESS (2.176s)
[407.208605] Starting dynamic subtest: evict
[409.264259] Dynamic subtest evict: SUCCESS (2.090s)
[409.295487] Starting dynamic subtest: hugepages
[411.395786] Dynamic subtest hugepages: SUCCESS (2.127s)
[411.426914] Starting dynamic subtest: gem_contexts
[413.494807] Dynamic subtest gem_contexts: SUCCESS (2.093s)
[413.525405] Starting dynamic subtest: client
[415.612451] Dynamic subtest client: SUCCESS (2.114s)
[415.642173] Starting dynamic subtest: gem_migrate
[417.733603] Dynamic subtest gem_migrate: SUCCESS (2.116s)
[417.763599] Starting dynamic subtest: reset
[420.398134] Dynamic subtest reset: SUCCESS (2.660s)
[420.429837] Starting dynamic subtest: memory_region
[422.510769] Dynamic subtest memory_region: SUCCESS (2.108s)
[422.540386] Starting dynamic subtest: hangcheck
[425.740509] Dynamic subtest hangcheck: SUCCESS (3.224s)
[425.769874] Starting dynamic subtest: execlists
[427.829285] Dynamic subtest execlists: SUCCESS (2.083s)
[427.858811] Starting dynamic subtest: ring_submission
[429.972327] Dynamic subtest ring_submission: SUCCESS (2.138s)
[430.010479] Starting dynamic subtest: perf
[432.070730] Dynamic subtest perf: SUCCESS (2.093s)
[432.101786] Starting dynamic subtest: slpc
[434.186687] Dynamic subtest slpc: SUCCESS (2.112s)
[434.222084] Starting dynamic subtest: guc
[436.280224] Dynamic subtest guc: SUCCESS (2.087s)
[436.310270] Starting dynamic subtest: guc_multi_lrc
[438.401617] Dynamic subtest guc_multi_lrc: SUCCESS (2.114s)
[438.439455] Starting dynamic subtest: guc_hang
[440.517783] Dynamic subtest guc_hang: SUCCESS (2.113s)
[440.551616] Starting dynamic subtest: late_gt_pm
[442.647540] Dynamic subtest late_gt_pm: SUCCESS (2.124s)
[442.651593] Subtest live: SUCCESS (111.442s)
[442.744267] [160/160] (613s left) dmabuf (all-tests)
[443.201308] Starting subtest: all-tests
[443.204309] Starting dynamic subtest: sanitycheck
[443.295642] Dynamic subtest sanitycheck: SUCCESS (0.095s)
[443.339278] Starting dynamic subtest: dma_fence
[443.513735] Dynamic subtest dma_fence: SUCCESS (0.215s)
[443.552696] Starting dynamic subtest: dma_fence_chain
[495.392547] Dynamic subtest dma_fence_chain: SUCCESS (51.848s)
[495.430251] Starting dynamic subtest: dma_fence_unwrap
[495.492616] Dynamic subtest dma_fence_unwrap: SUCCESS (0.097s)
[495.532477] Starting dynamic subtest: dma_resv
[495.595387] Dynamic subtest dma_resv: SUCCESS (0.099s)
[495.599604] Subtest all-tests: SUCCESS (52.375s)
[495.680686] Closing watchdogs
Done.