[41.791770] Initializing watchdogs
[41.791834]   /dev/watchdog0
[41.797191] [001/171] (960s left) i915_module_load (load)
[41.847300] Starting subtest: load
[42.917130] Subtest load: SUCCESS (1.069s)
[42.962808] [002/171] (959s left) core_auth (basic-auth)
[43.108658] Starting subtest: basic-auth
[43.111223] Subtest basic-auth: SUCCESS (0.002s)
[43.133973] [003/171] (959s left) debugfs_test (read_all_entries)
[43.233150] Starting subtest: read_all_entries
[43.533101] Subtest read_all_entries: SUCCESS (0.300s)
[43.648615] [004/171] (958s left) debugfs_test (basic-hwmon)
[43.707721] Starting subtest: basic-hwmon
[43.710532] Subtest basic-hwmon: SUCCESS (0.002s)
[43.825774] [005/171] (958s left) fbdev (eof)
[44.509436] Subtest eof: SKIP (0.000s)
[44.518298] [006/171] (957s left) fbdev (info)
[44.575202] Subtest info: SKIP (0.000s)
[44.583297] [007/171] (957s left) fbdev (nullptr)
[44.639826] Subtest nullptr: SKIP (0.000s)
[44.648132] [008/171] (957s left) fbdev (read)
[44.703323] Subtest read: SKIP (0.000s)
[44.712314] [009/171] (957s left) fbdev (write)
[44.767007] Subtest write: SKIP (0.000s)
[44.775298] [010/171] (957s left) gem_basic (bad-close)
[44.831341] Starting subtest: bad-close
[44.833095] Subtest bad-close: SUCCESS (0.000s)
[44.840810] [011/171] (957s left) gem_basic (create-close)
[44.895566] Starting subtest: create-close
[44.897319] Subtest create-close: SUCCESS (0.000s)
[44.922731] [012/171] (957s left) gem_basic (create-fd-close)
[44.979335] Starting subtest: create-fd-close
[44.981065] Subtest create-fd-close: SUCCESS (0.000s)
[45.011661] [013/171] (957s left) gem_busy (busy@all-engines)
[45.080862] Starting subtest: busy
[45.081825] Starting dynamic subtest: all-engines
[45.179692] Dynamic subtest all-engines: SUCCESS (0.099s)
[45.180714] Subtest busy: SUCCESS (0.099s)
[45.521339] [014/171] (956s left) gem_close_race (basic-process)
[45.645748] Starting subtest: basic-process
[45.695410] Subtest basic-process: SUCCESS (0.050s)
[45.846938] [015/171] (956s left) gem_close_race (basic-threads)
[45.935061] Starting subtest: basic-threads
[47.119481] Subtest basic-threads: SUCCESS (1.184s)
[47.289660] [016/171] (955s left) gem_ctx_create (basic)
[47.409342] Starting subtest: basic
[47.410554] Subtest basic: SUCCESS (0.000s)
[47.526077] [017/171] (955s left) gem_ctx_create (basic-files)
[47.608977] Starting subtest: basic-files
[49.619930] Subtest basic-files: SUCCESS (2.011s)
[50.376719] [018/171] (952s left) gem_ctx_exec (basic)
[50.438726] Starting subtest: basic
[50.442215] Subtest basic: SUCCESS (0.004s)
[50.479522] [019/171] (952s left) gem_exec_basic (basic)
[50.543275] Starting subtest: basic
[50.545151] Starting dynamic subtest: rcs0-smem
[50.546041] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[50.550894] Starting dynamic subtest: bcs0-smem
[50.551698] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[50.555995] Starting dynamic subtest: vcs0-smem
[50.556842] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[50.560936] Starting dynamic subtest: vcs1-smem
[50.561741] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[50.565895] Starting dynamic subtest: vecs0-smem
[50.566711] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[50.570825] Starting dynamic subtest: vecs1-smem
[50.571629] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[50.575704] Starting dynamic subtest: ccs0-smem
[50.576864] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[50.581397] Starting dynamic subtest: ccs1-smem
[50.582382] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[50.586674] Starting dynamic subtest: ccs2-smem
[50.587752] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[50.591857] Starting dynamic subtest: ccs3-smem
[50.592637] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[50.596750] Starting dynamic subtest: rcs0-lmem0
[50.597521] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[50.601659] Starting dynamic subtest: bcs0-lmem0
[50.602447] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[50.606738] Starting dynamic subtest: vcs0-lmem0
[50.607763] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[50.612103] Starting dynamic subtest: vcs1-lmem0
[50.612968] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[50.617449] Starting dynamic subtest: vecs0-lmem0
[50.618622] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[50.622669] Starting dynamic subtest: vecs1-lmem0
[50.623453] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[50.627509] Starting dynamic subtest: ccs0-lmem0
[50.628290] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[50.632338] Starting dynamic subtest: ccs1-lmem0
[50.633116] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[50.637148] Starting dynamic subtest: ccs2-lmem0
[50.637928] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[50.642396] Starting dynamic subtest: ccs3-lmem0
[50.643628] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[50.644807] Subtest basic: SUCCESS (0.013s)
[50.672728] [020/171] (951s left) gem_exec_create (basic)
[50.737371] Starting subtest: basic
[50.738211] Starting dynamic subtest: smem
[52.829652] Dynamic subtest smem: SUCCESS (2.092s)
[52.834276] Starting dynamic subtest: lmem0
[54.929765] Dynamic subtest lmem0: SUCCESS (2.100s)
[54.931043] Subtest basic: SUCCESS (4.192s)
[55.057456] [021/171] (947s left) gem_exec_fence (basic-busy)
[55.244284] Starting subtest: basic-busy
[55.245883] Starting dynamic subtest: rcs0
[55.348155] Dynamic subtest rcs0: SUCCESS (0.104s)
[55.356360] Starting dynamic subtest: bcs0
[55.395922] Dynamic subtest bcs0: SUCCESS (0.048s)
[55.403372] Starting dynamic subtest: vcs0
[55.445071] Dynamic subtest vcs0: SUCCESS (0.048s)
[55.462645] Starting dynamic subtest: vcs1
[55.501913] Dynamic subtest vcs1: SUCCESS (0.057s)
[55.507703] Starting dynamic subtest: vecs0
[55.554957] Dynamic subtest vecs0: SUCCESS (0.052s)
[55.573923] Starting dynamic subtest: vecs1
[55.614085] Dynamic subtest vecs1: SUCCESS (0.059s)
[55.632844] Starting dynamic subtest: ccs0
[55.667139] Dynamic subtest ccs0: SUCCESS (0.053s)
[55.686046] Starting dynamic subtest: ccs1
[55.723281] Dynamic subtest ccs1: SUCCESS (0.056s)
[55.742249] Starting dynamic subtest: ccs2
[55.777880] Dynamic subtest ccs2: SUCCESS (0.054s)
[55.796729] Starting dynamic subtest: ccs3
[55.834274] Dynamic subtest ccs3: SUCCESS (0.056s)
[55.836155] Subtest basic-busy: SUCCESS (0.590s)
[56.920133] [022/171] (945s left) gem_exec_fence (basic-wait)
[57.102334] Starting subtest: basic-wait
[57.103312] Starting dynamic subtest: rcs0
[57.198424] Dynamic subtest rcs0: SUCCESS (0.095s)
[57.206917] Starting dynamic subtest: bcs0
[57.245856] Dynamic subtest bcs0: SUCCESS (0.048s)
[57.252999] Starting dynamic subtest: vcs0
[57.297856] Dynamic subtest vcs0: SUCCESS (0.052s)
[57.308526] Starting dynamic subtest: vcs1
[57.352896] Dynamic subtest vcs1: SUCCESS (0.054s)
[57.372647] Starting dynamic subtest: vecs0
[57.411108] Dynamic subtest vecs0: SUCCESS (0.058s)
[57.430586] Starting dynamic subtest: vecs1
[57.466191] Dynamic subtest vecs1: SUCCESS (0.055s)
[57.485655] Starting dynamic subtest: ccs0
[57.523096] Dynamic subtest ccs0: SUCCESS (0.056s)
[57.542634] Starting dynamic subtest: ccs1
[57.581100] Dynamic subtest ccs1: SUCCESS (0.058s)
[57.600505] Starting dynamic subtest: ccs2
[57.639034] Dynamic subtest ccs2: SUCCESS (0.057s)
[57.658106] Starting dynamic subtest: ccs3
[57.701080] Dynamic subtest ccs3: SUCCESS (0.062s)
[57.703040] Subtest basic-wait: SUCCESS (0.598s)
[58.711290] [023/171] (943s left) gem_exec_fence (basic-await)
[58.889958] Starting subtest: basic-await
[58.890849] Starting dynamic subtest: rcs0
[59.004916] Dynamic subtest rcs0: SUCCESS (0.115s)
[59.009608] Starting dynamic subtest: bcs0
[59.099243] Dynamic subtest bcs0: SUCCESS (0.094s)
[59.104737] Starting dynamic subtest: vcs0
[59.195869] Dynamic subtest vcs0: SUCCESS (0.097s)
[59.200805] Starting dynamic subtest: vcs1
[59.290567] Dynamic subtest vcs1: SUCCESS (0.094s)
[59.295531] Starting dynamic subtest: vecs0
[59.385376] Dynamic subtest vecs0: SUCCESS (0.095s)
[59.390845] Starting dynamic subtest: vecs1
[59.482624] Dynamic subtest vecs1: SUCCESS (0.097s)
[59.487800] Starting dynamic subtest: ccs0
[59.577935] Dynamic subtest ccs0: SUCCESS (0.095s)
[59.583294] Starting dynamic subtest: ccs1
[59.673970] Dynamic subtest ccs1: SUCCESS (0.096s)
[59.679101] Starting dynamic subtest: ccs2
[59.767571] Dynamic subtest ccs2: SUCCESS (0.093s)
[59.772609] Starting dynamic subtest: ccs3
[59.862074] Dynamic subtest ccs3: SUCCESS (0.095s)
[59.862949] Subtest basic-await: SUCCESS (0.972s)
[60.940503] [024/171] (941s left) gem_exec_fence (nb-await)
[61.121518] Starting subtest: nb-await
[61.122465] Starting dynamic subtest: rcs0
[61.211754] Dynamic subtest rcs0: SUCCESS (0.090s)
[61.216961] Starting dynamic subtest: bcs0
[61.277775] Dynamic subtest bcs0: SUCCESS (0.065s)
[61.287535] Starting dynamic subtest: vcs0
[61.346723] Dynamic subtest vcs0: SUCCESS (0.069s)
[61.354148] Starting dynamic subtest: vcs1
[61.418233] Dynamic subtest vcs1: SUCCESS (0.071s)
[61.437190] Starting dynamic subtest: vecs0
[61.509723] Dynamic subtest vecs0: SUCCESS (0.091s)
[61.529347] Starting dynamic subtest: vecs1
[61.601515] Dynamic subtest vecs1: SUCCESS (0.091s)
[61.619335] Starting dynamic subtest: ccs0
[61.690447] Dynamic subtest ccs0: SUCCESS (0.089s)
[61.711920] Starting dynamic subtest: ccs1
[61.786693] Dynamic subtest ccs1: SUCCESS (0.096s)
[61.798028] Starting dynamic subtest: ccs2
[61.865994] Dynamic subtest ccs2: SUCCESS (0.078s)
[61.887406] Starting dynamic subtest: ccs3
[61.957230] Dynamic subtest ccs3: SUCCESS (0.092s)
[61.958447] Subtest nb-await: SUCCESS (0.836s)
[62.971258] [025/171] (939s left) gem_exec_gttfill (basic)
[63.040038] Starting subtest: basic
[68.950808] Subtest basic: SUCCESS (5.902s)
[69.117675] [026/171] (933s left) gem_exec_parallel (engines)
[69.226376] Starting subtest: engines
[69.227189] Starting dynamic subtest: basic
[71.026653] Dynamic subtest basic: SUCCESS (1.800s)
[71.031805] Starting dynamic subtest: contexts
[75.342229] Dynamic subtest contexts: SUCCESS (4.306s)
[75.347500] Starting dynamic subtest: fds
[79.146592] Dynamic subtest fds: SUCCESS (3.804s)
[79.152283] Starting dynamic subtest: userptr
[80.778409] Dynamic subtest userptr: SUCCESS (1.640s)
[80.779595] Subtest engines: SUCCESS (11.552s)
[80.987972] [027/171] (921s left) gem_exec_store (basic)
[81.081415] Starting subtest: basic
[81.214653] Subtest basic: SUCCESS (0.132s)
[81.404890] [028/171] (921s left) gem_flink_basic (bad-flink)
[81.477517] Starting subtest: bad-flink
[81.478431] Subtest bad-flink: SUCCESS (0.000s)
[81.487228] [029/171] (921s left) gem_flink_basic (bad-open)
[81.543816] Starting subtest: bad-open
[81.544741] Subtest bad-open: SUCCESS (0.000s)
[81.554195] [030/171] (921s left) gem_flink_basic (basic)
[81.612399] Starting subtest: basic
[81.613298] Subtest basic: SUCCESS (0.000s)
[81.651369] [031/171] (921s left) gem_flink_basic (double-flink)
[81.710367] Starting subtest: double-flink
[81.711178] Subtest double-flink: SUCCESS (0.000s)
[81.732906] [032/171] (921s left) gem_flink_basic (flink-lifetime)
[81.790591] Starting subtest: flink-lifetime
[81.792449] Subtest flink-lifetime: SUCCESS (0.001s)
[81.828099] [033/171] (920s left) gem_huc_copy (huc-copy)
[81.913941] Starting subtest: huc-copy
[81.920970] Subtest huc-copy: SUCCESS (0.007s)
[81.999710] [034/171] (920s left) gem_linear_blits (basic)
[82.140082] Starting subtest: basic
[82.160877] Subtest basic: SUCCESS (0.021s)
[82.242461] [035/171] (920s left) gem_mmap (basic)
[82.344261] Subtest basic: SKIP (0.000s)
[82.354496] [036/171] (920s left) gem_mmap_gtt (basic)
[82.413958] Subtest basic: SKIP (0.000s)
[82.423233] [037/171] (920s left) gem_render_linear_blits (basic)
[82.487417] Starting subtest: basic
[82.543976] Subtest basic: SUCCESS (0.056s)
[82.610436] [038/171] (920s left) gem_render_tiled_blits (basic)
[82.703091] Subtest basic: SKIP (0.000s)
[82.712813] [039/171] (920s left) gem_ringfill (basic-all)
[83.120045] Starting subtest: basic-all
[86.045078] Subtest basic-all: SUCCESS (2.919s)
[86.085069] [040/171] (916s left) gem_softpin (allocator-basic)
[86.165641] Starting subtest: allocator-basic
[86.332031] Subtest allocator-basic: SUCCESS (0.158s)
[86.370555] [041/171] (916s left) gem_softpin (allocator-basic-reserve)
[86.437343] Starting subtest: allocator-basic-reserve
[86.599764] Subtest allocator-basic-reserve: SUCCESS (0.154s)
[86.661916] [042/171] (916s left) gem_softpin (safe-alignment)
[86.775252] Starting subtest: safe-alignment
[86.831414] Subtest safe-alignment: SUCCESS (0.056s)
[86.885909] [043/171] (916s left) gem_sync (basic-all)
[86.957899] Starting subtest: basic-all
[89.210187] Subtest basic-all: SUCCESS (2.253s)
[89.344809] [044/171] (913s left) gem_sync (basic-each)
[89.418892] Starting subtest: basic-each
[92.393627] Subtest basic-each: SUCCESS (2.975s)
[92.517281] [045/171] (910s left) gem_tiled_blits (basic)
[92.595944] Subtest basic: SKIP (0.000s)
[92.606282] [046/171] (910s left) gem_tiled_fence_blits (basic)
[92.668930] Subtest basic: SKIP (0.000s)
[92.679709] [047/171] (910s left) gem_tiled_pread_basic
[92.750495] [048/171] (910s left) gem_wait (busy@all-engines)
[92.819633] Starting subtest: busy
[92.820561] Starting dynamic subtest: all-engines
[93.397299] Dynamic subtest all-engines: SUCCESS (0.578s)
[93.398241] Subtest busy: SUCCESS (0.578s)
[93.568289] [049/171] (909s left) gem_wait (wait@all-engines)
[93.645158] Starting subtest: wait
[93.645986] Starting dynamic subtest: all-engines
[94.732197] Dynamic subtest all-engines: SUCCESS (1.087s)
[94.733138] Subtest wait: SUCCESS (1.087s)
[94.925097] [050/171] (908s left) i915_getparams_basic (basic-eu-total)
[95.011063] Starting subtest: basic-eu-total
[95.012994] Subtest basic-eu-total: SUCCESS (0.000s)
[95.021648] [051/171] (908s left) i915_getparams_basic (basic-subslice-total)
[95.079351] Starting subtest: basic-subslice-total
[95.081063] Subtest basic-subslice-total: SUCCESS (0.000s)
[95.090131] [052/171] (907s left) i915_hangman (error-state-basic)
[95.162920] Starting subtest: error-state-basic
[95.343168] Subtest error-state-basic: SUCCESS (0.181s)
[95.362631] [053/171] (907s left) i915_pciid
[95.435591] [054/171] (907s left) kms_addfb_basic (addfb25-bad-modifier)
[95.494065] Starting subtest: addfb25-bad-modifier
[95.494967] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[95.656164] [055/171] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[95.714511] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[95.872180] [056/171] (907s left) kms_addfb_basic (addfb25-modifier-no-flag)
[95.929729] Starting subtest: addfb25-modifier-no-flag
[95.930501] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[96.080642] [057/171] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[96.139216] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[96.295635] [058/171] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[96.355181] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[96.501566] [059/171] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[96.681131] Starting subtest: addfb25-yf-tiled-legacy
[96.682056] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[96.703293] [060/171] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[96.882611] Starting subtest: addfb25-y-tiled-legacy
[96.883465] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[96.918320] [061/171] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[97.095775] Starting subtest: addfb25-y-tiled-small-legacy
[97.097432] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[97.129325] [062/171] (906s left) kms_addfb_basic (bad-pitch-0)
[97.187762] Starting subtest: bad-pitch-0
[97.188697] Subtest bad-pitch-0: SUCCESS (0.000s)
[97.338297] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024)
[97.396807] Starting subtest: bad-pitch-1024
[97.397751] Subtest bad-pitch-1024: SUCCESS (0.000s)
[97.547371] [064/171] (905s left) kms_addfb_basic (bad-pitch-128)
[97.604769] Starting subtest: bad-pitch-128
[97.605589] Subtest bad-pitch-128: SUCCESS (0.000s)
[97.759092] [065/171] (905s left) kms_addfb_basic (bad-pitch-256)
[97.816547] Starting subtest: bad-pitch-256
[97.817475] Subtest bad-pitch-256: SUCCESS (0.000s)
[97.972303] [066/171] (905s left) kms_addfb_basic (bad-pitch-32)
[98.030303] Starting subtest: bad-pitch-32
[98.031093] Subtest bad-pitch-32: SUCCESS (0.000s)
[98.183621] [067/171] (905s left) kms_addfb_basic (bad-pitch-63)
[98.241904] Starting subtest: bad-pitch-63
[98.242860] Subtest bad-pitch-63: SUCCESS (0.000s)
[98.397477] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536)
[98.455365] Starting subtest: bad-pitch-65536
[98.456291] Subtest bad-pitch-65536: SUCCESS (0.000s)
[98.599934] [069/171] (904s left) kms_addfb_basic (bad-pitch-999)
[98.658757] Starting subtest: bad-pitch-999
[98.659679] Subtest bad-pitch-999: SUCCESS (0.000s)
[98.813811] [070/171] (904s left) kms_addfb_basic (basic)
[98.870989] Starting subtest: basic
[98.871755] Subtest basic: SUCCESS (0.000s)
[99.029537] [071/171] (904s left) kms_addfb_basic (basic-x-tiled-legacy)
[99.090106] Starting subtest: basic-x-tiled-legacy
[99.091769] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[99.230788] [072/171] (904s left) kms_addfb_basic (basic-y-tiled-legacy)
[99.290140] Starting subtest: basic-y-tiled-legacy
[99.291778] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[99.436147] [073/171] (903s left) kms_addfb_basic (bo-too-small)
[99.615059] Starting subtest: bo-too-small
[99.615996] Subtest bo-too-small: SUCCESS (0.000s)
[99.647764] [074/171] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[99.825771] Starting subtest: bo-too-small-due-to-tiling
[99.827447] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[99.850825] [075/171] (903s left) kms_addfb_basic (clobberred-modifier)
[99.908865] Starting subtest: clobberred-modifier
[99.910587] Subtest clobberred-modifier: SKIP (0.000s)
[100.064837] [076/171] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[100.122254] Starting subtest: framebuffer-vs-set-tiling
[100.123974] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[100.264270] [077/171] (903s left) kms_addfb_basic (invalid-get-prop)
[100.321657] Starting subtest: invalid-get-prop
[100.322576] Subtest invalid-get-prop: SUCCESS (0.000s)
[100.484561] [078/171] (902s left) kms_addfb_basic (invalid-get-prop-any)
[100.541352] Starting subtest: invalid-get-prop-any
[100.542263] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[100.692371] [079/171] (902s left) kms_addfb_basic (invalid-set-prop)
[100.749557] Starting subtest: invalid-set-prop
[100.750396] Subtest invalid-set-prop: SUCCESS (0.000s)
[100.901160] [080/171] (902s left) kms_addfb_basic (invalid-set-prop-any)
[100.959728] Starting subtest: invalid-set-prop-any
[100.960565] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[101.106878] [081/171] (902s left) kms_addfb_basic (no-handle)
[101.163211] Starting subtest: no-handle
[101.164054] Subtest no-handle: SUCCESS (0.000s)
[101.304900] [082/171] (902s left) kms_addfb_basic (size-max)
[101.482919] Starting subtest: size-max
[101.483732] Subtest size-max: SUCCESS (0.000s)
[101.506279] [083/171] (901s left) kms_addfb_basic (small-bo)
[101.681998] Starting subtest: small-bo
[101.682919] Subtest small-bo: SUCCESS (0.000s)
[101.704410] [084/171] (901s left) kms_addfb_basic (tile-pitch-mismatch)
[101.763155] Starting subtest: tile-pitch-mismatch
[101.764747] Subtest tile-pitch-mismatch: SKIP (0.000s)
[101.917091] [085/171] (901s left) kms_addfb_basic (too-high)
[102.092961] Starting subtest: too-high
[102.093890] Subtest too-high: SUCCESS (0.000s)
[102.116661] [086/171] (901s left) kms_addfb_basic (too-wide)
[102.294763] Starting subtest: too-wide
[102.295570] Subtest too-wide: SUCCESS (0.000s)
[102.324656] [087/171] (901s left) kms_addfb_basic (unused-handle)
[102.382413] Starting subtest: unused-handle
[102.383229] Subtest unused-handle: SUCCESS (0.000s)
[102.540581] [088/171] (900s left) kms_addfb_basic (unused-modifier)
[102.598825] Starting subtest: unused-modifier
[102.599755] Subtest unused-modifier: SUCCESS (0.000s)
[102.752859] [089/171] (900s left) kms_addfb_basic (unused-offsets)
[102.811826] Starting subtest: unused-offsets
[102.812635] Subtest unused-offsets: SUCCESS (0.000s)
[102.965482] [090/171] (900s left) kms_addfb_basic (unused-pitches)
[103.022441] Starting subtest: unused-pitches
[103.023294] Subtest unused-pitches: SUCCESS (0.000s)
[103.165201] [091/171] (900s left) kms_busy (basic)
[103.348770] Subtest basic: SKIP (0.000s)
[103.359415] [092/171] (900s left) kms_chamelium_hpd (dp-hpd-fast)
[103.541393] Subtest dp-hpd-fast: SKIP (0.000s)
[103.552371] [093/171] (900s left) kms_chamelium_edid (dp-edid-read)
[103.733490] Subtest dp-edid-read: SKIP (0.000s)
[103.744499] [094/171] (899s left) kms_chamelium_frames (dp-crc-fast)
[103.925723] Subtest dp-crc-fast: SKIP (0.000s)
[103.936945] [095/171] (899s left) kms_chamelium_hpd (hdmi-hpd-fast)
[104.117486] Subtest hdmi-hpd-fast: SKIP (0.000s)
[104.128616] [096/171] (899s left) kms_chamelium_edid (hdmi-edid-read)
[104.309112] Subtest hdmi-edid-read: SKIP (0.000s)
[104.320108] [097/171] (899s left) kms_chamelium_frames (hdmi-crc-fast)
[104.501599] Subtest hdmi-crc-fast: SKIP (0.000s)
[104.512912] [098/171] (899s left) kms_chamelium_hpd (vga-hpd-fast)
[104.694528] Subtest vga-hpd-fast: SKIP (0.000s)
[104.705198] [099/171] (898s left) kms_chamelium_edid (vga-edid-read)
[104.887167] Subtest vga-edid-read: SKIP (0.000s)
[104.897788] [100/171] (898s left) kms_prop_blob (basic)
[104.956412] Starting subtest: basic
[104.957363] Subtest basic: SUCCESS (0.000s)
[104.966665] [101/171] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[105.148190] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[105.158289] [102/171] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[105.339568] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[105.349309] [103/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[105.535312] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[105.545648] [104/171] (898s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[105.726936] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[105.736387] [105/171] (897s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[105.918591] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[105.928447] [106/171] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[106.110028] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[106.119723] [107/171] (897s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[106.301074] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[106.310680] [108/171] (897s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[106.492224] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[106.501726] [109/171] (897s left) kms_flip (basic-flip-vs-dpms)
[106.616844] Starting subtest: basic-flip-vs-dpms
[106.619466] Subtest basic-flip-vs-dpms: SKIP (0.003s)
[106.648311] [110/171] (897s left) kms_flip (basic-flip-vs-modeset)
[106.762589] Starting subtest: basic-flip-vs-modeset
[106.765935] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[106.795894] [111/171] (896s left) kms_flip (basic-flip-vs-wf_vblank)
[106.909902] Starting subtest: basic-flip-vs-wf_vblank
[106.912594] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[106.930865] [112/171] (896s left) kms_flip (basic-plain-flip)
[107.044620] Starting subtest: basic-plain-flip
[107.047447] Subtest basic-plain-flip: SKIP (0.003s)
[107.077466] [113/171] (896s left) kms_force_connector_basic (force-connector-state)
[107.154992] Starting subtest: force-connector-state
[107.670786] Subtest force-connector-state: SUCCESS (0.517s)
[107.897973] [114/171] (895s left) kms_force_connector_basic (force-edid)
[107.975860] Starting subtest: force-edid
[108.000057] Subtest force-edid: SUCCESS (0.024s)
[108.159280] [115/171] (895s left) kms_force_connector_basic (force-load-detect)
[108.234193] Starting subtest: force-load-detect
[108.235992] Subtest force-load-detect: SKIP (0.000s)
[108.338269] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[108.413671] Starting subtest: prune-stale-modes
[108.429974] Subtest prune-stale-modes: SKIP (0.016s)
[108.586271] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[108.765686] Subtest basic: SKIP (0.000s)
[108.796119] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[108.975716] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[108.991033] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[109.169994] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[109.184648] [120/171] (894s left) kms_pipe_crc_basic (hang-read-crc)
[109.363015] Subtest hang-read-crc: SKIP (0.000s)
[109.378602] [121/171] (894s left) kms_pipe_crc_basic (nonblocking-crc)
[109.556974] Subtest nonblocking-crc: SKIP (0.000s)
[109.573342] [122/171] (894s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[109.750636] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[109.767356] [123/171] (894s left) kms_pipe_crc_basic (read-crc)
[109.945727] Subtest read-crc: SKIP (0.000s)
[109.961991] [124/171] (893s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[110.139793] Subtest read-crc-frame-sequence: SKIP (0.000s)
[110.155903] [125/171] (893s left) kms_psr (primary_page_flip)
[110.214463] Subtest primary_page_flip: SKIP (0.000s)
[110.229146] [126/171] (893s left) kms_psr (cursor_plane_move)
[110.289177] Subtest cursor_plane_move: SKIP (0.000s)
[110.303703] [127/171] (893s left) kms_psr (sprite_plane_onoff)
[110.362895] Subtest sprite_plane_onoff: SKIP (0.000s)
[110.377138] [128/171] (893s left) kms_psr (primary_mmap_gtt)
[110.436387] Subtest primary_mmap_gtt: SKIP (0.000s)
[110.450797] [129/171] (893s left) kms_setmode (basic-clone-single-crtc)
[110.508578] Starting subtest: basic-clone-single-crtc
[110.510942] Subtest basic-clone-single-crtc: SKIP (0.000s)
[110.528363] [130/171] (893s left) i915_pm_backlight (basic-brightness)
[110.707027] Subtest basic-brightness: SKIP (0.000s)
[110.724593] [131/171] (893s left) i915_pm_rpm (basic-pci-d3-state)
[112.808404] Starting subtest: basic-pci-d3-state
[113.626207] Subtest basic-pci-d3-state: SUCCESS (0.817s)
[113.708650] [132/171] (890s left) i915_pm_rpm (basic-rte)
[113.764188] Starting subtest: basic-rte
[116.989071] Subtest basic-rte: SUCCESS (3.231s)
[117.967449] [133/171] (886s left) i915_pm_rps (basic-api)
[118.031007] Starting subtest: basic-api
[118.032590] Subtest basic-api: SKIP (0.000s)
[118.051168] [134/171] (886s left) prime_self_import (basic-llseek-bad)
[118.099204] Starting subtest: basic-llseek-bad
[118.110578] Subtest basic-llseek-bad: SUCCESS (0.011s)
[118.142315] [135/171] (885s left) prime_self_import (basic-llseek-size)
[118.188954] Starting subtest: basic-llseek-size
[118.200446] Subtest basic-llseek-size: SUCCESS (0.012s)
[118.229781] [136/171] (885s left) prime_self_import (basic-with_fd_dup)
[118.276527] Starting subtest: basic-with_fd_dup
[118.288682] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[118.331785] [137/171] (885s left) prime_self_import (basic-with_one_bo)
[118.379557] Starting subtest: basic-with_one_bo
[118.392389] Subtest basic-with_one_bo: SUCCESS (0.013s)
[118.413796] [138/171] (885s left) prime_self_import (basic-with_one_bo_two_files)
[118.460938] Starting subtest: basic-with_one_bo_two_files
[118.473055] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[118.510422] [139/171] (885s left) prime_self_import (basic-with_two_bos)
[118.562316] Starting subtest: basic-with_two_bos
[118.576022] Subtest basic-with_two_bos: SUCCESS (0.013s)
[118.611592] [140/171] (885s left) prime_vgem (basic-fence-flip)
[118.682500] Starting subtest: basic-fence-flip
[118.803944] Subtest basic-fence-flip: SKIP (0.120s)
[118.825780] [141/171] (885s left) prime_vgem (basic-fence-mmap)
[118.891547] Starting subtest: basic-fence-mmap
[118.893140] Subtest basic-fence-mmap: SKIP (0.000s)
[118.933392] [142/171] (885s left) prime_vgem (basic-fence-read)
[118.997503] Starting subtest: basic-fence-read
[119.004527] Subtest basic-fence-read: SKIP (0.007s)
[119.045707] [143/171] (885s left) prime_vgem (basic-gtt)
[119.109952] Starting subtest: basic-gtt
[119.111499] Subtest basic-gtt: SKIP (0.000s)
[119.153997] [144/171] (885s left) prime_vgem (basic-read)
[119.222925] Starting subtest: basic-read
[119.227745] Subtest basic-read: SKIP (0.004s)
[119.274881] [145/171] (884s left) prime_vgem (basic-write)
[119.355633] Starting subtest: basic-write
[119.360114] Subtest basic-write: SKIP (0.004s)
[119.404078] [146/171] (884s left) vgem_basic (setversion)
[119.457256] Starting subtest: setversion
[119.458924] Subtest setversion: SUCCESS (0.000s)
[119.472852] [147/171] (884s left) vgem_basic (create)
[119.523247] Starting subtest: create
[119.524046] Subtest create: SUCCESS (0.000s)
[119.540197] [148/171] (884s left) vgem_basic (debugfs)
[119.590269] Starting subtest: debugfs
[119.591253] Subtest debugfs: SUCCESS (0.000s)
[119.607176] [149/171] (884s left) vgem_basic (dmabuf-export)
[119.658051] Starting subtest: dmabuf-export
[119.669094] Subtest dmabuf-export: SUCCESS (0.012s)
[119.710377] [150/171] (884s left) vgem_basic (dmabuf-fence)
[119.760124] Starting subtest: dmabuf-fence
[119.761007] Subtest dmabuf-fence: SUCCESS (0.000s)
[119.776502] [151/171] (884s left) vgem_basic (dmabuf-fence-before)
[119.826688] Starting subtest: dmabuf-fence-before
[119.827589] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[119.856115] [152/171] (884s left) vgem_basic (dmabuf-mmap)
[119.912704] Starting subtest: dmabuf-mmap
[119.919997] Subtest dmabuf-mmap: SUCCESS (0.009s)
[119.937701] [153/171] (884s left) vgem_basic (mmap)
[119.988286] Starting subtest: mmap
[119.992401] Subtest mmap: SUCCESS (0.006s)
[120.009086] [154/171] (884s left) vgem_basic (second-client)
[120.059890] Starting subtest: second-client
[120.065569] Subtest second-client: SUCCESS (0.005s)
[120.081535] [155/171] (884s left) vgem_basic (sysfs)
[120.132829] Starting subtest: sysfs
[120.133628] Subtest sysfs: SUCCESS (0.000s)
[120.148871] [156/171] (884s left) core_hotunplug (unbind-rebind)
[120.230915] Starting subtest: unbind-rebind
[122.104741] Subtest unbind-rebind: SUCCESS (1.874s)
[122.123742] [157/171] (882s left) vgem_basic (unload)
[122.177798] Starting subtest: unload
[151.067630] Subtest unload: SUCCESS (28.853s)
[151.084999] [158/171] (853s left) i915_module_load (reload)
[151.132401] Starting subtest: reload
[153.682186] Subtest reload: SUCCESS (2.549s)
[153.694878] [159/171] (850s left) gem_lmem_swapping (basic)
[156.644379] Starting subtest: basic
[156.645480] Starting dynamic subtest: lmem0
[175.766706] Dynamic subtest lmem0: SUCCESS (19.118s)
[175.767662] Subtest basic: SUCCESS (19.118s)
[178.246908] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[178.784701] Starting subtest: parallel-random-engines
[178.785501] Starting dynamic subtest: lmem0
[179.583762] Dynamic subtest lmem0: SUCCESS (0.799s)
[179.584514] Subtest parallel-random-engines: SUCCESS (0.800s)
[180.860676] [161/171] (823s left) gem_lmem_swapping (random-engines)
[181.358253] Starting subtest: random-engines
[181.359025] Starting dynamic subtest: lmem0
[182.084110] Dynamic subtest lmem0: SUCCESS (0.717s)
[182.085034] Subtest random-engines: SUCCESS (0.717s)
[183.440818] [162/171] (821s left) gem_lmem_swapping (verify-random)
[183.932652] Starting subtest: verify-random
[183.933446] Starting dynamic subtest: lmem0
[191.374698] Dynamic subtest lmem0: SUCCESS (7.433s)
[191.375605] Subtest verify-random: SUCCESS (7.434s)
[192.794192] [163/171] (811s left) i915_pm_rpm (module-reload)
[194.946031] Starting subtest: module-reload
[204.419407] Subtest module-reload: SUCCESS (9.464s)
[204.445039] [164/171] (800s left) i915_selftest (live)
[204.497749] Starting subtest: live
[204.498636] Starting dynamic subtest: sanitycheck
[205.868391] Dynamic subtest sanitycheck: SUCCESS (1.362s)
[205.874047] Starting dynamic subtest: uncore
[207.229196] Dynamic subtest uncore: SUCCESS (1.360s)
[207.235622] Starting dynamic subtest: workarounds
[211.641148] Dynamic subtest workarounds: SUCCESS (4.411s)
[211.646856] Starting dynamic subtest: gt_engines
[214.073294] Dynamic subtest gt_engines: SUCCESS (2.432s)
[214.078556] Starting dynamic subtest: gt_timelines
[241.721219] Dynamic subtest gt_timelines: SUCCESS (27.647s)
[241.726310] Starting dynamic subtest: gt_contexts
[243.124169] Dynamic subtest gt_contexts: SUCCESS (1.402s)
[243.128926] Starting dynamic subtest: gt_lrc
[250.928263] Dynamic subtest gt_lrc: SUCCESS (7.803s)
[250.933583] Starting dynamic subtest: gt_mocs
[254.539243] Dynamic subtest gt_mocs: SUCCESS (3.610s)
[254.543925] Starting dynamic subtest: gt_pm
[256.832184] Dynamic subtest gt_pm: SUCCESS (2.292s)
[256.838194] Starting dynamic subtest: gt_heartbeat
[258.457380] Dynamic subtest gt_heartbeat: SUCCESS (1.624s)
[258.464788] Starting dynamic subtest: gt_tlb
[270.614422] Dynamic subtest gt_tlb: SUCCESS (12.156s)
[270.620475] Starting dynamic subtest: requests
[288.158290] Dynamic subtest requests: SUCCESS (17.543s)
[288.163272] Starting dynamic subtest: migrate
[292.641361] Dynamic subtest migrate: SUCCESS (4.482s)
[292.647143] Starting dynamic subtest: active
[294.025104] Dynamic subtest active: SUCCESS (1.383s)
[294.031542] Starting dynamic subtest: objects
[296.233196] Dynamic subtest objects: SUCCESS (2.207s)
[296.238608] Starting dynamic subtest: mman
[304.715363] Dynamic subtest mman: SUCCESS (8.484s)
[304.720273] Starting dynamic subtest: dmabuf
[306.128366] Dynamic subtest dmabuf: SUCCESS (1.410s)
[306.133277] Starting dynamic subtest: vma
[307.488985] Dynamic subtest vma: SUCCESS (1.359s)
[307.493868] Starting dynamic subtest: coherency
[310.613926] Dynamic subtest coherency: SUCCESS (3.124s)
[310.618772] Starting dynamic subtest: gtt
[319.346383] Dynamic subtest gtt: SUCCESS (8.731s)
[319.352522] Starting dynamic subtest: gem
[320.768485] Dynamic subtest gem: SUCCESS (1.421s)
[320.774723] Starting dynamic subtest: evict
[324.322218] Dynamic subtest evict: SUCCESS (3.553s)
[324.327957] Starting dynamic subtest: hugepages
[342.273273] Dynamic subtest hugepages: SUCCESS (17.950s)
[342.279124] Starting dynamic subtest: gem_contexts
[382.684047] Dynamic subtest gem_contexts: SUCCESS (40.384s)
[382.688953] Starting dynamic subtest: client
[384.089273] Dynamic subtest client: SUCCESS (1.430s)
[384.095161] Starting dynamic subtest: gem_migrate
[389.088393] Dynamic subtest gem_migrate: SUCCESS (4.998s)
[389.093480] Starting dynamic subtest: reset
[390.564165] Dynamic subtest reset: SUCCESS (1.475s)
[390.569139] Starting dynamic subtest: memory_region
[393.476191] Dynamic subtest memory_region: SUCCESS (2.911s)
[393.480948] Starting dynamic subtest: hangcheck
[440.078479] Dynamic subtest hangcheck: SUCCESS (46.601s)
[440.084754] Starting dynamic subtest: execlists
[441.446261] Dynamic subtest execlists: SUCCESS (1.367s)
[441.451706] Starting dynamic subtest: ring_submission
[442.809194] Dynamic subtest ring_submission: SUCCESS (1.362s)
[442.815364] Starting dynamic subtest: perf
[444.293196] Dynamic subtest perf: SUCCESS (1.483s)
[444.298179] Starting dynamic subtest: slpc
[453.503210] Dynamic subtest slpc: SUCCESS (9.209s)
[453.509119] Starting dynamic subtest: guc
[456.315047] Dynamic subtest guc: SUCCESS (2.810s)
[456.320063] Starting dynamic subtest: guc_multi_lrc
[457.739179] Dynamic subtest guc_multi_lrc: SUCCESS (1.424s)
[457.744381] Starting dynamic subtest: guc_hang
[459.870255] Dynamic subtest guc_hang: SUCCESS (2.130s)
[459.875780] Starting dynamic subtest: late_gt_pm
[461.329108] Dynamic subtest late_gt_pm: SUCCESS (1.457s)
[461.330593] Subtest live: SUCCESS (256.823s)
[461.783920] [165/171] (542s left) dmabuf (all-tests)
[461.834138] Starting subtest: all-tests
[461.835676] Starting dynamic subtest: sanitycheck
[461.904769] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[461.917945] Starting dynamic subtest: dma_fence
[462.096822] Dynamic subtest dma_fence: SUCCESS (0.190s)
[462.115851] Starting dynamic subtest: dma_fence_chain
[472.640832] Dynamic subtest dma_fence_chain: SUCCESS (10.541s)
[472.648435] Starting dynamic subtest: dma_fence_unwrap
[472.707052] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s)
[472.724647] Starting dynamic subtest: dma_resv
[472.794381] Dynamic subtest dma_resv: SUCCESS (0.084s)
[472.795701] Subtest all-tests: SUCCESS (10.961s)
[472.827394] [166/171] (531s left) i915_suspend (basic-s2idle-without-i915)
[472.912911] Starting subtest: basic-s2idle-without-i915
[492.476223] Subtest basic-s2idle-without-i915: SUCCESS (4.718s)
[492.510039] [167/171] (526s left) i915_suspend (basic-s3-without-i915)
[492.559487] Starting subtest: basic-s3-without-i915
[514.074674] Subtest basic-s3-without-i915: SUCCESS (5.660s)
[514.107472] [168/171] (521s left) gem_exec_suspend (basic-s0)
[514.188060] Starting subtest: basic-S0
[514.189056] Starting dynamic subtest: smem
[534.223537] Dynamic subtest smem: SUCCESS (4.625s)
[534.231111] Starting dynamic subtest: lmem0
[554.221406] Dynamic subtest lmem0: SUCCESS (5.196s)
[554.222440] Subtest basic-S0: SUCCESS (9.822s)
[554.394099] [169/171] (511s left) gem_exec_suspend (basic-s3)
[554.478394] Starting subtest: basic-S3
[554.479321] Starting dynamic subtest: smem
[575.543005] Dynamic subtest smem: SUCCESS (5.585s)
[575.550206] Starting dynamic subtest: lmem0
[596.539219] Dynamic subtest lmem0: SUCCESS (5.196s)
[596.540286] Subtest basic-S3: SUCCESS (10.782s)
[596.703208] [170/171] (500s left) kms_chamelium_hpd (common-hpd-after-suspend)
[596.920198] Subtest common-hpd-after-suspend: SKIP (0.000s)
[596.935772] [171/171] (499s left) kms_pipe_crc_basic (suspend-read-crc)
[597.123656] Subtest suspend-read-crc: SKIP (0.000s)
[597.138197] Closing watchdogs
Done.