[43.204353] Initializing watchdogs
[43.204452]   /dev/watchdog0
[43.211625] [001/171] (960s left) i915_module_load (load)
[43.293023] Starting subtest: load
[44.618034] Subtest load: SUCCESS (1.325s)
[44.634278] [002/171] (959s left) core_auth (basic-auth)
[44.780127] Starting subtest: basic-auth
[44.781186] Subtest basic-auth: SUCCESS (0.001s)
[44.837366] [003/171] (958s left) debugfs_test (read_all_entries)
[44.938888] Starting subtest: read_all_entries
[45.452974] Subtest read_all_entries: SUCCESS (0.513s)
[45.572340] [004/171] (958s left) debugfs_test (basic-hwmon)
[45.670754] Starting subtest: basic-hwmon
[45.675115] Subtest basic-hwmon: SUCCESS (0.004s)
[45.806303] [005/171] (957s left) fbdev (eof)
[45.885310] Starting subtest: eof
[45.886378] Subtest eof: SUCCESS (0.000s)
[45.939577] [006/171] (957s left) fbdev (info)
[46.016562] Starting subtest: info
[46.017568] Subtest info: SUCCESS (0.000s)
[46.072287] [007/171] (957s left) fbdev (nullptr)
[46.151815] Starting subtest: nullptr
[46.153023] Subtest nullptr: SUCCESS (0.000s)
[46.204854] [008/171] (957s left) fbdev (read)
[46.302054] Starting subtest: read
[58.639430] Subtest read: SUCCESS (12.329s)
[58.689176] [009/171] (945s left) fbdev (write)
[58.768729] Starting subtest: write
[64.895193] Subtest write: SUCCESS (6.118s)
[64.939713] [010/171] (938s left) gem_basic (bad-close)
[65.029242] Starting subtest: bad-close
[65.031220] Subtest bad-close: SUCCESS (0.000s)
[65.089736] [011/171] (938s left) gem_basic (create-close)
[65.179142] Starting subtest: create-close
[65.181167] Subtest create-close: SUCCESS (0.000s)
[65.279707] [012/171] (938s left) gem_basic (create-fd-close)
[65.371094] Starting subtest: create-fd-close
[65.372823] Subtest create-fd-close: SUCCESS (0.000s)
[65.441219] [013/171] (938s left) gem_busy (busy@all-engines)
[65.547271] Starting subtest: busy
[65.548355] Starting dynamic subtest: all-engines
[65.668089] Dynamic subtest all-engines: SUCCESS (0.121s)
[65.668953] Subtest busy: SUCCESS (0.121s)
[66.120907] [014/171] (937s left) gem_close_race (basic-process)
[66.262933] Starting subtest: basic-process
[66.318686] Subtest basic-process: SUCCESS (0.055s)
[66.572785] [015/171] (937s left) gem_close_race (basic-threads)
[66.705124] Starting subtest: basic-threads
[67.922508] Subtest basic-threads: SUCCESS (1.217s)
[68.170251] [016/171] (935s left) gem_ctx_create (basic)
[68.287275] Starting subtest: basic
[68.288531] Subtest basic: SUCCESS (0.000s)
[68.520689] [017/171] (935s left) gem_ctx_create (basic-files)
[68.625510] Starting subtest: basic-files
[70.641974] Subtest basic-files: SUCCESS (2.016s)
[71.133327] [018/171] (932s left) gem_ctx_exec (basic)
[71.234807] Starting subtest: basic
[71.239410] Subtest basic: SUCCESS (0.005s)
[71.346664] [019/171] (932s left) gem_exec_basic (basic)
[71.458568] Starting subtest: basic
[71.459511] Starting dynamic subtest: rcs0-smem
[71.461248] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[71.467176] Starting dynamic subtest: bcs0-smem
[71.468059] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[71.474621] Starting dynamic subtest: vcs0-smem
[71.475506] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[71.481047] Starting dynamic subtest: vcs1-smem
[71.481884] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[71.487379] Starting dynamic subtest: vecs0-smem
[71.488299] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[71.494038] Starting dynamic subtest: vecs1-smem
[71.495138] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[71.500655] Starting dynamic subtest: ccs0-smem
[71.501691] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[71.507134] Starting dynamic subtest: ccs1-smem
[71.507967] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[71.513288] Starting dynamic subtest: ccs2-smem
[71.514393] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[71.519969] Starting dynamic subtest: ccs3-smem
[71.521087] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[71.526649] Starting dynamic subtest: rcs0-lmem0
[71.527679] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[71.533244] Starting dynamic subtest: bcs0-lmem0
[71.534336] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[71.539967] Starting dynamic subtest: vcs0-lmem0
[71.541088] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[71.546660] Starting dynamic subtest: vcs1-lmem0
[71.547688] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[71.553393] Starting dynamic subtest: vecs0-lmem0
[71.554489] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[71.560152] Starting dynamic subtest: vecs1-lmem0
[71.561149] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[71.566801] Starting dynamic subtest: ccs0-lmem0
[71.567904] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[71.573362] Starting dynamic subtest: ccs1-lmem0
[71.574282] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[71.580063] Starting dynamic subtest: ccs2-lmem0
[71.580919] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[71.586368] Starting dynamic subtest: ccs3-lmem0
[71.587192] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[71.588024] Subtest basic: SUCCESS (0.014s)
[71.664638] [020/171] (932s left) gem_exec_create (basic)
[71.799101] Starting subtest: basic
[71.800176] Starting dynamic subtest: smem
[73.902388] Dynamic subtest smem: SUCCESS (2.104s)
[73.910864] Starting dynamic subtest: lmem0
[76.024155] Dynamic subtest lmem0: SUCCESS (2.122s)
[76.025347] Subtest basic: SUCCESS (4.226s)
[76.256564] [021/171] (927s left) gem_exec_fence (basic-busy)
[76.485732] Starting subtest: basic-busy
[76.486845] Starting dynamic subtest: rcs0
[76.566423] Dynamic subtest rcs0: SUCCESS (0.089s)
[76.572305] Starting dynamic subtest: bcs0
[76.610510] Dynamic subtest bcs0: SUCCESS (0.044s)
[76.616479] Starting dynamic subtest: vcs0
[76.655828] Dynamic subtest vcs0: SUCCESS (0.044s)
[76.664646] Starting dynamic subtest: vcs1
[76.711200] Dynamic subtest vcs1: SUCCESS (0.055s)
[76.736908] Starting dynamic subtest: vecs0
[76.768454] Dynamic subtest vecs0: SUCCESS (0.057s)
[76.794060] Starting dynamic subtest: vecs1
[76.826173] Dynamic subtest vecs1: SUCCESS (0.057s)
[76.849095] Starting dynamic subtest: ccs0
[76.890622] Dynamic subtest ccs0: SUCCESS (0.064s)
[76.916634] Starting dynamic subtest: ccs1
[76.946607] Dynamic subtest ccs1: SUCCESS (0.056s)
[76.971260] Starting dynamic subtest: ccs2
[77.003244] Dynamic subtest ccs2: SUCCESS (0.057s)
[77.019570] Starting dynamic subtest: ccs3
[77.058469] Dynamic subtest ccs3: SUCCESS (0.054s)
[77.060868] Subtest basic-busy: SUCCESS (0.580s)
[77.792506] [022/171] (926s left) gem_exec_fence (basic-wait)
[78.026271] Starting subtest: basic-wait
[78.027362] Starting dynamic subtest: rcs0
[78.119786] Dynamic subtest rcs0: SUCCESS (0.101s)
[78.145395] Starting dynamic subtest: bcs0
[78.183208] Dynamic subtest bcs0: SUCCESS (0.063s)
[78.212199] Starting dynamic subtest: vcs0
[78.250099] Dynamic subtest vcs0: SUCCESS (0.067s)
[78.262725] Starting dynamic subtest: vcs1
[78.311056] Dynamic subtest vcs1: SUCCESS (0.059s)
[78.337086] Starting dynamic subtest: vecs0
[78.369568] Dynamic subtest vecs0: SUCCESS (0.059s)
[78.395096] Starting dynamic subtest: vecs1
[78.430366] Dynamic subtest vecs1: SUCCESS (0.060s)
[78.456615] Starting dynamic subtest: ccs0
[78.488162] Dynamic subtest ccs0: SUCCESS (0.057s)
[78.514208] Starting dynamic subtest: ccs1
[78.547143] Dynamic subtest ccs1: SUCCESS (0.059s)
[78.573218] Starting dynamic subtest: ccs2
[78.611214] Dynamic subtest ccs2: SUCCESS (0.063s)
[78.637437] Starting dynamic subtest: ccs3
[78.666364] Dynamic subtest ccs3: SUCCESS (0.055s)
[78.668620] Subtest basic-wait: SUCCESS (0.648s)
[79.321648] [023/171] (924s left) gem_exec_fence (basic-await)
[79.604383] Starting subtest: basic-await
[79.605660] Starting dynamic subtest: rcs0
[79.745642] Dynamic subtest rcs0: SUCCESS (0.150s)
[79.751581] Starting dynamic subtest: bcs0
[79.857427] Dynamic subtest bcs0: SUCCESS (0.112s)
[79.863372] Starting dynamic subtest: vcs0
[79.969191] Dynamic subtest vcs0: SUCCESS (0.112s)
[79.975132] Starting dynamic subtest: vcs1
[80.081305] Dynamic subtest vcs1: SUCCESS (0.112s)
[80.087192] Starting dynamic subtest: vecs0
[80.193708] Dynamic subtest vecs0: SUCCESS (0.112s)
[80.199735] Starting dynamic subtest: vecs1
[80.305398] Dynamic subtest vecs1: SUCCESS (0.112s)
[80.311513] Starting dynamic subtest: ccs0
[80.417728] Dynamic subtest ccs0: SUCCESS (0.112s)
[80.423859] Starting dynamic subtest: ccs1
[80.529890] Dynamic subtest ccs1: SUCCESS (0.112s)
[80.535896] Starting dynamic subtest: ccs2
[80.647295] Dynamic subtest ccs2: SUCCESS (0.117s)
[80.653580] Starting dynamic subtest: ccs3
[80.763543] Dynamic subtest ccs3: SUCCESS (0.116s)
[80.764619] Subtest basic-await: SUCCESS (1.168s)
[81.466523] [024/171] (922s left) gem_exec_fence (nb-await)
[81.697942] Starting subtest: nb-await
[81.704422] Starting dynamic subtest: rcs0
[81.814642] Dynamic subtest rcs0: SUCCESS (0.113s)
[81.842125] Starting dynamic subtest: bcs0
[81.910610] Dynamic subtest bcs0: SUCCESS (0.106s)
[81.925705] Starting dynamic subtest: vcs0
[81.997092] Dynamic subtest vcs0: SUCCESS (0.086s)
[82.020042] Starting dynamic subtest: vcs1
[82.093720] Dynamic subtest vcs1: SUCCESS (0.097s)
[82.113324] Starting dynamic subtest: vecs0
[82.184605] Dynamic subtest vecs0: SUCCESS (0.091s)
[82.206987] Starting dynamic subtest: vecs1
[82.284520] Dynamic subtest vecs1: SUCCESS (0.100s)
[82.299201] Starting dynamic subtest: ccs0
[82.372403] Dynamic subtest ccs0: SUCCESS (0.087s)
[82.381879] Starting dynamic subtest: ccs1
[82.443121] Dynamic subtest ccs1: SUCCESS (0.071s)
[82.455895] Starting dynamic subtest: ccs2
[82.531170] Dynamic subtest ccs2: SUCCESS (0.087s)
[82.537732] Starting dynamic subtest: ccs3
[82.599961] Dynamic subtest ccs3: SUCCESS (0.069s)
[82.601532] Subtest nb-await: SUCCESS (0.909s)
[83.282655] [025/171] (920s left) gem_exec_gttfill (basic)
[83.390227] Starting subtest: basic
[90.736060] Subtest basic: SUCCESS (7.337s)
[90.939272] [026/171] (913s left) gem_exec_parallel (engines)
[91.096683] Starting subtest: engines
[91.097682] Starting dynamic subtest: basic
[93.073908] Dynamic subtest basic: SUCCESS (1.977s)
[93.086159] Starting dynamic subtest: contexts
[96.327567] Dynamic subtest contexts: SUCCESS (3.254s)
[96.334482] Starting dynamic subtest: fds
[99.682657] Dynamic subtest fds: SUCCESS (3.346s)
[99.689245] Starting dynamic subtest: userptr
[101.382165] Dynamic subtest userptr: SUCCESS (1.707s)
[101.383905] Subtest engines: SUCCESS (10.285s)
[101.689175] [027/171] (902s left) gem_exec_store (basic)
[101.810097] Starting subtest: basic
[101.936208] Subtest basic: SUCCESS (0.126s)
[102.190066] [028/171] (901s left) gem_flink_basic (bad-flink)
[102.283077] Starting subtest: bad-flink
[102.284054] Subtest bad-flink: SUCCESS (0.000s)
[102.341221] [029/171] (901s left) gem_flink_basic (bad-open)
[102.433989] Starting subtest: bad-open
[102.434964] Subtest bad-open: SUCCESS (0.000s)
[102.490612] [030/171] (901s left) gem_flink_basic (basic)
[102.583032] Starting subtest: basic
[102.584071] Subtest basic: SUCCESS (0.000s)
[102.687132] [031/171] (901s left) gem_flink_basic (double-flink)
[102.778148] Starting subtest: double-flink
[102.779174] Subtest double-flink: SUCCESS (0.000s)
[102.864945] [032/171] (901s left) gem_flink_basic (flink-lifetime)
[102.971351] Starting subtest: flink-lifetime
[102.973540] Subtest flink-lifetime: SUCCESS (0.002s)
[103.085133] [033/171] (901s left) gem_huc_copy (huc-copy)
[103.234194] Starting subtest: huc-copy
[103.242244] Subtest huc-copy: SUCCESS (0.007s)
[103.373988] [034/171] (900s left) gem_linear_blits (basic)
[103.584248] Starting subtest: basic
[103.621725] Subtest basic: SUCCESS (0.038s)
[103.776923] [035/171] (900s left) gem_mmap (basic)
[103.926496] Subtest basic: SKIP (0.000s)
[103.961374] [036/171] (900s left) gem_mmap_gtt (basic)
[104.055638] Subtest basic: SKIP (0.000s)
[104.096157] [037/171] (900s left) gem_render_linear_blits (basic)
[104.200684] Starting subtest: basic
[104.287049] Subtest basic: SUCCESS (0.086s)
[104.364872] [038/171] (900s left) gem_render_tiled_blits (basic)
[104.489938] Subtest basic: SKIP (0.000s)
[104.528295] [039/171] (899s left) gem_ringfill (basic-all)
[104.999927] Starting subtest: basic-all
[106.403760] Subtest basic-all: SUCCESS (1.397s)
[106.528612] [040/171] (897s left) gem_softpin (allocator-basic)
[106.659124] Starting subtest: allocator-basic
[106.930457] Subtest allocator-basic: SUCCESS (0.263s)
[107.053941] [041/171] (897s left) gem_softpin (allocator-basic-reserve)
[107.185204] Starting subtest: allocator-basic-reserve
[107.457487] Subtest allocator-basic-reserve: SUCCESS (0.264s)
[107.580681] [042/171] (896s left) gem_softpin (safe-alignment)
[107.681406] Starting subtest: safe-alignment
[107.754519] Subtest safe-alignment: SUCCESS (0.073s)
[107.861580] [043/171] (896s left) gem_sync (basic-all)
[107.966989] Starting subtest: basic-all
[112.019805] Subtest basic-all: SUCCESS (4.052s)
[112.205284] [044/171] (892s left) gem_sync (basic-each)
[112.319675] Starting subtest: basic-each
[114.872463] Subtest basic-each: SUCCESS (2.553s)
[115.093514] [045/171] (889s left) gem_tiled_blits (basic)
[115.205142] Subtest basic: SKIP (0.000s)
[115.246955] [046/171] (889s left) gem_tiled_fence_blits (basic)
[115.359683] Subtest basic: SKIP (0.000s)
[115.395647] [047/171] (889s left) gem_tiled_pread_basic
[115.528554] [048/171] (889s left) gem_wait (busy@all-engines)
[115.641268] Starting subtest: busy
[115.642422] Starting dynamic subtest: all-engines
[116.223826] Dynamic subtest all-engines: SUCCESS (0.583s)
[116.224865] Subtest busy: SUCCESS (0.583s)
[116.471347] [049/171] (888s left) gem_wait (wait@all-engines)
[116.581776] Starting subtest: wait
[116.582854] Starting dynamic subtest: all-engines
[117.683298] Dynamic subtest all-engines: SUCCESS (1.101s)
[117.684434] Subtest wait: SUCCESS (1.102s)
[117.957176] [050/171] (886s left) i915_getparams_basic (basic-eu-total)
[118.061156] Starting subtest: basic-eu-total
[118.063175] Subtest basic-eu-total: SUCCESS (0.000s)
[118.127159] [051/171] (886s left) i915_getparams_basic (basic-subslice-total)
[118.227157] Starting subtest: basic-subslice-total
[118.229103] Subtest basic-subslice-total: SUCCESS (0.000s)
[118.295728] [052/171] (886s left) i915_hangman (error-state-basic)
[118.410078] Starting subtest: error-state-basic
[118.607822] Subtest error-state-basic: SUCCESS (0.198s)
[118.680777] [053/171] (886s left) i915_pciid
[118.842170] [054/171] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[118.940047] Starting subtest: addfb25-bad-modifier
[118.941045] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[119.095273] [055/171] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[119.194415] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[119.360067] [056/171] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[119.455266] Starting subtest: addfb25-modifier-no-flag
[119.456317] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[119.609776] [057/171] (885s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[119.703769] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[119.843212] [058/171] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.937873] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[120.093321] [059/171] (884s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[120.250098] Starting subtest: addfb25-yf-tiled-legacy
[120.251188] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[120.326491] [060/171] (884s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[120.481027] Starting subtest: addfb25-y-tiled-legacy
[120.482066] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[120.557847] [061/171] (884s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[120.713618] Starting subtest: addfb25-y-tiled-small-legacy
[120.715569] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[120.793202] [062/171] (884s left) kms_addfb_basic (bad-pitch-0)
[120.886192] Starting subtest: bad-pitch-0
[120.887256] Subtest bad-pitch-0: SUCCESS (0.000s)
[121.026287] [063/171] (883s left) kms_addfb_basic (bad-pitch-1024)
[121.121197] Starting subtest: bad-pitch-1024
[121.122224] Subtest bad-pitch-1024: SUCCESS (0.000s)
[121.259658] [064/171] (883s left) kms_addfb_basic (bad-pitch-128)
[121.351947] Starting subtest: bad-pitch-128
[121.352908] Subtest bad-pitch-128: SUCCESS (0.000s)
[121.493238] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[121.587256] Starting subtest: bad-pitch-256
[121.588301] Subtest bad-pitch-256: SUCCESS (0.000s)
[121.726218] [066/171] (883s left) kms_addfb_basic (bad-pitch-32)
[121.820184] Starting subtest: bad-pitch-32
[121.821248] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.960008] [067/171] (882s left) kms_addfb_basic (bad-pitch-63)
[122.054281] Starting subtest: bad-pitch-63
[122.055305] Subtest bad-pitch-63: SUCCESS (0.000s)
[122.195611] [068/171] (882s left) kms_addfb_basic (bad-pitch-65536)
[122.287229] Starting subtest: bad-pitch-65536
[122.288305] Subtest bad-pitch-65536: SUCCESS (0.000s)
[122.443618] [069/171] (882s left) kms_addfb_basic (bad-pitch-999)
[122.537057] Starting subtest: bad-pitch-999
[122.538061] Subtest bad-pitch-999: SUCCESS (0.000s)
[122.676465] [070/171] (882s left) kms_addfb_basic (basic)
[122.769276] Starting subtest: basic
[122.770377] Subtest basic: SUCCESS (0.000s)
[122.910290] [071/171] (882s left) kms_addfb_basic (basic-x-tiled-legacy)
[123.005347] Starting subtest: basic-x-tiled-legacy
[123.007288] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[123.159663] [072/171] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[123.253404] Starting subtest: basic-y-tiled-legacy
[123.255394] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[123.393420] [073/171] (881s left) kms_addfb_basic (bo-too-small)
[123.549553] Starting subtest: bo-too-small
[123.550617] Subtest bo-too-small: SUCCESS (0.000s)
[123.644036] [074/171] (881s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[123.799852] Starting subtest: bo-too-small-due-to-tiling
[123.801994] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.894218] [075/171] (881s left) kms_addfb_basic (clobberred-modifier)
[123.987303] Starting subtest: clobberred-modifier
[123.989380] Subtest clobberred-modifier: SKIP (0.000s)
[124.126598] [076/171] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[124.223237] Starting subtest: framebuffer-vs-set-tiling
[124.225252] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[124.359996] [077/171] (880s left) kms_addfb_basic (invalid-get-prop)
[124.455203] Starting subtest: invalid-get-prop
[124.456238] Subtest invalid-get-prop: SUCCESS (0.000s)
[124.593352] [078/171] (880s left) kms_addfb_basic (invalid-get-prop-any)
[124.686316] Starting subtest: invalid-get-prop-any
[124.687388] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.826447] [079/171] (880s left) kms_addfb_basic (invalid-set-prop)
[124.919183] Starting subtest: invalid-set-prop
[124.920242] Subtest invalid-set-prop: SUCCESS (0.000s)
[125.059721] [080/171] (880s left) kms_addfb_basic (invalid-set-prop-any)
[125.155448] Starting subtest: invalid-set-prop-any
[125.156478] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[125.294767] [081/171] (879s left) kms_addfb_basic (no-handle)
[125.387933] Starting subtest: no-handle
[125.388915] Subtest no-handle: SUCCESS (0.000s)
[125.543086] [082/171] (879s left) kms_addfb_basic (size-max)
[125.698619] Starting subtest: size-max
[125.699597] Subtest size-max: SUCCESS (0.000s)
[125.793233] [083/171] (879s left) kms_addfb_basic (small-bo)
[125.949937] Starting subtest: small-bo
[125.950871] Subtest small-bo: SUCCESS (0.000s)
[126.026697] [084/171] (879s left) kms_addfb_basic (tile-pitch-mismatch)
[126.120394] Starting subtest: tile-pitch-mismatch
[126.122474] Subtest tile-pitch-mismatch: SKIP (0.000s)
[126.260159] [085/171] (878s left) kms_addfb_basic (too-high)
[126.417357] Starting subtest: too-high
[126.418396] Subtest too-high: SUCCESS (0.001s)
[126.493071] [086/171] (878s left) kms_addfb_basic (too-wide)
[126.649967] Starting subtest: too-wide
[126.651064] Subtest too-wide: SUCCESS (0.000s)
[126.726687] [087/171] (878s left) kms_addfb_basic (unused-handle)
[126.820176] Starting subtest: unused-handle
[126.821154] Subtest unused-handle: SUCCESS (0.000s)
[126.960294] [088/171] (878s left) kms_addfb_basic (unused-modifier)
[127.054340] Starting subtest: unused-modifier
[127.055372] Subtest unused-modifier: SUCCESS (0.000s)
[127.193462] [089/171] (878s left) kms_addfb_basic (unused-offsets)
[127.287460] Starting subtest: unused-offsets
[127.288509] Subtest unused-offsets: SUCCESS (0.000s)
[127.443634] [090/171] (877s left) kms_addfb_basic (unused-pitches)
[127.536203] Starting subtest: unused-pitches
[127.537318] Subtest unused-pitches: SUCCESS (0.000s)
[127.676808] [091/171] (877s left) kms_busy (basic)
[127.850138] Starting subtest: basic
[127.851209] Starting dynamic subtest: flip
[128.646375] Dynamic subtest flip: SUCCESS (0.795s)
[128.654070] Starting dynamic subtest: modeset
[129.612268] Dynamic subtest modeset: SUCCESS (0.967s)
[129.613320] Subtest basic: SUCCESS (1.763s)
[129.826511] [092/171] (875s left) kms_chamelium_hpd (dp-hpd-fast)
[130.061715] Subtest dp-hpd-fast: SKIP (0.000s)
[130.195205] [093/171] (875s left) kms_chamelium_edid (dp-edid-read)
[130.425297] Subtest dp-edid-read: SKIP (0.000s)
[130.561827] [094/171] (874s left) kms_chamelium_frames (dp-crc-fast)
[130.793625] Subtest dp-crc-fast: SKIP (0.000s)
[130.927718] [095/171] (874s left) kms_chamelium_hpd (hdmi-hpd-fast)
[131.158253] Subtest hdmi-hpd-fast: SKIP (0.000s)
[131.292163] [096/171] (874s left) kms_chamelium_edid (hdmi-edid-read)
[131.522308] Subtest hdmi-edid-read: SKIP (0.000s)
[131.656533] [097/171] (873s left) kms_chamelium_frames (hdmi-crc-fast)
[131.887181] Subtest hdmi-crc-fast: SKIP (0.000s)
[132.021647] [098/171] (873s left) kms_chamelium_hpd (vga-hpd-fast)
[132.252094] Subtest vga-hpd-fast: SKIP (0.000s)
[132.384514] [099/171] (873s left) kms_chamelium_edid (vga-edid-read)
[132.615177] Subtest vga-edid-read: SKIP (0.000s)
[132.749587] [100/171] (872s left) kms_prop_blob (basic)
[132.843298] Starting subtest: basic
[132.844378] Subtest basic: SUCCESS (0.000s)
[132.910212] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[133.065458] Starting subtest: basic-busy-flip-before-cursor-atomic
[133.067493] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[133.127205] [102/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[133.281910] Starting subtest: basic-busy-flip-before-cursor-legacy
[133.283696] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[133.343680] [103/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[133.499773] Starting subtest: basic-flip-after-cursor-atomic
[134.562274] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.063s)
[134.776016] [104/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.931967] Starting subtest: basic-flip-after-cursor-legacy
[136.009649] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.077s)
[136.213296] [105/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.378383] Starting subtest: basic-flip-after-cursor-varying-size
[137.446731] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.078s)
[137.652406] [106/171] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[137.809693] Starting subtest: basic-flip-before-cursor-atomic
[138.869748] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.061s)
[139.082925] [107/171] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[139.238885] Starting subtest: basic-flip-before-cursor-legacy
[140.318586] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.079s)
[140.523841] [108/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.683062] Starting subtest: basic-flip-before-cursor-varying-size
[141.775191] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.091s)
[141.985499] [109/171] (863s left) kms_flip (basic-flip-vs-dpms)
[142.128106] Starting subtest: basic-flip-vs-dpms
[142.133957] Starting dynamic subtest: A-DP1
[143.021972] Dynamic subtest A-DP1: SUCCESS (0.888s)
[143.029509] Starting dynamic subtest: B-DP1
[143.937730] Dynamic subtest B-DP1: SUCCESS (0.915s)
[143.945552] Starting dynamic subtest: C-DP1
[144.838283] Dynamic subtest C-DP1: SUCCESS (0.901s)
[144.846154] Starting dynamic subtest: D-DP1
[145.742859] Dynamic subtest D-DP1: SUCCESS (0.903s)
[145.746389] Subtest basic-flip-vs-dpms: SUCCESS (3.619s)
[145.964300] [110/171] (859s left) kms_flip (basic-flip-vs-modeset)
[146.104393] Starting subtest: basic-flip-vs-modeset
[146.109272] Starting dynamic subtest: A-DP1
[146.996327] Dynamic subtest A-DP1: SUCCESS (0.886s)
[147.004072] Starting dynamic subtest: B-DP1
[147.892854] Dynamic subtest B-DP1: SUCCESS (0.896s)
[147.900603] Starting dynamic subtest: C-DP1
[148.788302] Dynamic subtest C-DP1: SUCCESS (0.894s)
[148.796484] Starting dynamic subtest: D-DP1
[149.720118] Dynamic subtest D-DP1: SUCCESS (0.929s)
[149.722708] Subtest basic-flip-vs-modeset: SUCCESS (3.620s)
[149.937213] [111/171] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[150.081418] Starting subtest: basic-flip-vs-wf_vblank
[150.085863] Starting dynamic subtest: A-DP1
[151.291881] Dynamic subtest A-DP1: SUCCESS (1.206s)
[151.300122] Starting dynamic subtest: B-DP1
[152.411153] Dynamic subtest B-DP1: SUCCESS (1.118s)
[152.419183] Starting dynamic subtest: C-DP1
[153.530986] Dynamic subtest C-DP1: SUCCESS (1.119s)
[153.538824] Starting dynamic subtest: D-DP1
[154.648132] Dynamic subtest D-DP1: SUCCESS (1.116s)
[154.653059] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.574s)
[154.920555] [112/171] (850s left) kms_flip (basic-plain-flip)
[155.062380] Starting subtest: basic-plain-flip
[155.067279] Starting dynamic subtest: A-DP1
[155.981487] Dynamic subtest A-DP1: SUCCESS (0.914s)
[155.989478] Starting dynamic subtest: B-DP1
[156.852154] Dynamic subtest B-DP1: SUCCESS (0.870s)
[156.860164] Starting dynamic subtest: C-DP1
[157.685713] Dynamic subtest C-DP1: SUCCESS (0.833s)
[157.693860] Starting dynamic subtest: D-DP1
[158.504027] Dynamic subtest D-DP1: SUCCESS (0.816s)
[158.508299] Subtest basic-plain-flip: SUCCESS (3.447s)
[158.798460] [113/171] (846s left) kms_force_connector_basic (force-connector-state)
[158.897169] Starting subtest: force-connector-state
[159.464306] Subtest force-connector-state: SUCCESS (0.567s)
[159.755243] [114/171] (845s left) kms_force_connector_basic (force-edid)
[159.852064] Starting subtest: force-edid
[159.870974] Subtest force-edid: SUCCESS (0.018s)
[160.038702] [115/171] (845s left) kms_force_connector_basic (force-load-detect)
[160.135296] Starting subtest: force-load-detect
[160.137026] Subtest force-load-detect: SKIP (0.000s)
[160.255356] [116/171] (845s left) kms_force_connector_basic (prune-stale-modes)
[160.353565] Starting subtest: prune-stale-modes
[160.363059] Subtest prune-stale-modes: SKIP (0.009s)
[160.521854] [117/171] (845s left) kms_frontbuffer_tracking (basic)
[160.685049] Starting subtest: basic
[165.049406] Subtest basic: SUCCESS (4.366s)
[165.155388] [118/171] (840s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[165.315613] Starting subtest: compare-crc-sanitycheck-xr24
[165.316750] Starting dynamic subtest: pipe-A-DP-1
[165.906468] Dynamic subtest pipe-A-DP-1: SUCCESS (0.589s)
[165.916131] Starting dynamic subtest: pipe-B-DP-1
[166.475461] Dynamic subtest pipe-B-DP-1: SUCCESS (0.566s)
[166.483793] Starting dynamic subtest: pipe-C-DP-1
[167.111054] Dynamic subtest pipe-C-DP-1: SUCCESS (0.633s)
[167.119741] Starting dynamic subtest: pipe-D-DP-1
[167.805759] Dynamic subtest pipe-D-DP-1: SUCCESS (0.692s)
[167.806975] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.491s)
[168.006812] [119/171] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[168.165742] Starting subtest: compare-crc-sanitycheck-nv12
[168.166821] Starting dynamic subtest: pipe-A-DP-1
[169.389501] Dynamic subtest pipe-A-DP-1: SUCCESS (1.222s)
[169.398071] Starting dynamic subtest: pipe-B-DP-1
[170.539059] Dynamic subtest pipe-B-DP-1: SUCCESS (1.147s)
[170.547319] Starting dynamic subtest: pipe-C-DP-1
[171.719467] Dynamic subtest pipe-C-DP-1: SUCCESS (1.179s)
[171.729219] Starting dynamic subtest: pipe-D-DP-1
[173.048916] Dynamic subtest pipe-D-DP-1: SUCCESS (1.326s)
[173.050244] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.884s)
[173.253481] [120/171] (832s left) kms_pipe_crc_basic (hang-read-crc)
[173.411475] Starting subtest: hang-read-crc
[173.414279] Starting dynamic subtest: pipe-A-DP-1
[174.887572] Dynamic subtest pipe-A-DP-1: SUCCESS (1.473s)
[174.895818] Starting dynamic subtest: pipe-B-DP-1
[176.451560] Dynamic subtest pipe-B-DP-1: SUCCESS (1.562s)
[176.461021] Starting dynamic subtest: pipe-C-DP-1
[178.159593] Dynamic subtest pipe-C-DP-1: SUCCESS (1.705s)
[178.169693] Starting dynamic subtest: pipe-D-DP-1
[179.984528] Dynamic subtest pipe-D-DP-1: SUCCESS (1.822s)
[179.985729] Subtest hang-read-crc: SUCCESS (6.573s)
[180.189219] [121/171] (825s left) kms_pipe_crc_basic (nonblocking-crc)
[180.353564] Starting subtest: nonblocking-crc
[180.356580] Starting dynamic subtest: pipe-A-DP-1
[181.054186] Dynamic subtest pipe-A-DP-1: SUCCESS (0.698s)
[181.063499] Starting dynamic subtest: pipe-B-DP-1
[181.776359] Dynamic subtest pipe-B-DP-1: SUCCESS (0.719s)
[181.785572] Starting dynamic subtest: pipe-C-DP-1
[182.585905] Dynamic subtest pipe-C-DP-1: FAIL (0.561s)
[182.593845] Starting dynamic subtest: pipe-D-DP-1
[183.372434] Dynamic subtest pipe-D-DP-1: SUCCESS (0.845s)
[183.373429] Subtest nonblocking-crc: FAIL (3.018s)
[183.580335] [122/171] (822s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[183.739452] Starting subtest: nonblocking-crc-frame-sequence
[183.740547] Starting dynamic subtest: pipe-A-DP-1
[184.459535] Dynamic subtest pipe-A-DP-1: SUCCESS (0.705s)
[184.467696] Starting dynamic subtest: pipe-B-DP-1
[185.165143] Dynamic subtest pipe-B-DP-1: SUCCESS (0.716s)
[185.173779] Starting dynamic subtest: pipe-C-DP-1
[186.068604] Dynamic subtest pipe-C-DP-1: FAIL (0.799s)
[186.076494] Starting dynamic subtest: pipe-D-DP-1
[186.833596] Dynamic subtest pipe-D-DP-1: SUCCESS (0.865s)
[186.834623] Subtest nonblocking-crc-frame-sequence: FAIL (3.095s)
[187.032129] [123/171] (818s left) kms_pipe_crc_basic (read-crc)
[187.198274] Starting subtest: read-crc
[187.201473] Starting dynamic subtest: pipe-A-DP-1
[187.831528] Dynamic subtest pipe-A-DP-1: SUCCESS (0.630s)
[187.840808] Starting dynamic subtest: pipe-B-DP-1
[188.482683] Dynamic subtest pipe-B-DP-1: SUCCESS (0.648s)
[188.492760] Starting dynamic subtest: pipe-C-DP-1
[189.198469] Dynamic subtest pipe-C-DP-1: SUCCESS (0.713s)
[189.207427] Starting dynamic subtest: pipe-D-DP-1
[189.986399] Dynamic subtest pipe-D-DP-1: SUCCESS (0.784s)
[189.987455] Subtest read-crc: SUCCESS (2.787s)
[190.186061] [124/171] (815s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[190.344058] Starting subtest: read-crc-frame-sequence
[190.345153] Starting dynamic subtest: pipe-A-DP-1
[190.967584] Dynamic subtest pipe-A-DP-1: SUCCESS (0.622s)
[190.975788] Starting dynamic subtest: pipe-B-DP-1
[191.619108] Dynamic subtest pipe-B-DP-1: SUCCESS (0.649s)
[191.627593] Starting dynamic subtest: pipe-C-DP-1
[192.333479] Dynamic subtest pipe-C-DP-1: SUCCESS (0.712s)
[192.343259] Starting dynamic subtest: pipe-D-DP-1
[193.110176] Dynamic subtest pipe-D-DP-1: SUCCESS (0.774s)
[193.111230] Subtest read-crc-frame-sequence: SUCCESS (2.767s)
[193.306238] [125/171] (812s left) kms_psr (primary_page_flip)
[193.402775] Subtest primary_page_flip: SKIP (0.000s)
[193.442395] [126/171] (812s left) kms_psr (cursor_plane_move)
[193.537798] Subtest cursor_plane_move: SKIP (0.000s)
[193.575894] [127/171] (812s left) kms_psr (sprite_plane_onoff)
[193.671784] Subtest sprite_plane_onoff: SKIP (0.000s)
[193.708801] [128/171] (812s left) kms_psr (primary_mmap_gtt)
[193.803821] Subtest primary_mmap_gtt: SKIP (0.000s)
[193.842422] [129/171] (812s left) kms_setmode (basic-clone-single-crtc)
[193.938152] Starting subtest: basic-clone-single-crtc
[193.941150] Subtest basic-clone-single-crtc: SKIP (0.001s)
[194.005732] [130/171] (811s left) i915_pm_backlight (basic-brightness)
[194.160631] Subtest basic-brightness: SKIP (0.000s)
[194.195480] [131/171] (811s left) i915_pm_rpm (basic-pci-d3-state)
[196.498121] Starting subtest: basic-pci-d3-state
[197.573418] Subtest basic-pci-d3-state: SUCCESS (1.075s)
[197.730453] [132/171] (808s left) i915_pm_rpm (basic-rte)
[197.807608] Starting subtest: basic-rte
[200.347552] Subtest basic-rte: SUCCESS (2.540s)
[201.337298] [133/171] (804s left) i915_pm_rps (basic-api)
[201.441156] Starting subtest: basic-api
[201.443297] Subtest basic-api: SKIP (0.000s)
[201.504448] [134/171] (804s left) prime_self_import (basic-llseek-bad)
[201.580800] Starting subtest: basic-llseek-bad
[201.598513] Subtest basic-llseek-bad: SUCCESS (0.018s)
[201.702970] [135/171] (804s left) prime_self_import (basic-llseek-size)
[201.784628] Starting subtest: basic-llseek-size
[201.802924] Subtest basic-llseek-size: SUCCESS (0.018s)
[201.897867] [136/171] (804s left) prime_self_import (basic-with_fd_dup)
[201.992159] Starting subtest: basic-with_fd_dup
[202.010923] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[202.136500] [137/171] (804s left) prime_self_import (basic-with_one_bo)
[202.225051] Starting subtest: basic-with_one_bo
[202.244294] Subtest basic-with_one_bo: SUCCESS (0.019s)
[202.307168] [138/171] (803s left) prime_self_import (basic-with_one_bo_two_files)
[202.382119] Starting subtest: basic-with_one_bo_two_files
[202.402354] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s)
[202.508908] [139/171] (803s left) prime_self_import (basic-with_two_bos)
[202.593057] Starting subtest: basic-with_two_bos
[202.613355] Subtest basic-with_two_bos: SUCCESS (0.019s)
[202.719464] [140/171] (803s left) prime_vgem (basic-fence-flip)
[202.839418] Starting subtest: basic-fence-flip
[202.951378] Subtest basic-fence-flip: SKIP (0.111s)
[203.070605] [141/171] (803s left) prime_vgem (basic-fence-mmap)
[203.189366] Starting subtest: basic-fence-mmap
[203.191429] Subtest basic-fence-mmap: SKIP (0.000s)
[203.312768] [142/171] (802s left) prime_vgem (basic-fence-read)
[203.422232] Starting subtest: basic-fence-read
[203.429860] Subtest basic-fence-read: SKIP (0.006s)
[203.537897] [143/171] (802s left) prime_vgem (basic-gtt)
[203.654465] Starting subtest: basic-gtt
[203.656635] Subtest basic-gtt: SKIP (0.000s)
[203.780975] [144/171] (802s left) prime_vgem (basic-read)
[203.921391] Starting subtest: basic-read
[203.928303] Subtest basic-read: SKIP (0.006s)
[204.041756] [145/171] (802s left) prime_vgem (basic-write)
[204.187402] Starting subtest: basic-write
[204.195471] Subtest basic-write: SKIP (0.007s)
[204.304862] [146/171] (802s left) vgem_basic (setversion)
[204.397415] Starting subtest: setversion
[204.399695] Subtest setversion: SUCCESS (0.000s)
[204.457149] [147/171] (801s left) vgem_basic (create)
[204.547407] Starting subtest: create
[204.548574] Subtest create: SUCCESS (0.000s)
[204.613823] [148/171] (801s left) vgem_basic (debugfs)
[204.697490] Starting subtest: debugfs
[204.698557] Subtest debugfs: SUCCESS (0.000s)
[204.753842] [149/171] (801s left) vgem_basic (dmabuf-export)
[204.847486] Starting subtest: dmabuf-export
[204.866060] Subtest dmabuf-export: SUCCESS (0.018s)
[204.974871] [150/171] (801s left) vgem_basic (dmabuf-fence)
[205.097436] Starting subtest: dmabuf-fence
[205.098619] Subtest dmabuf-fence: SUCCESS (0.000s)
[205.157932] [151/171] (801s left) vgem_basic (dmabuf-fence-before)
[205.247424] Starting subtest: dmabuf-fence-before
[205.248535] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[205.303884] [152/171] (801s left) vgem_basic (dmabuf-mmap)
[205.397380] Starting subtest: dmabuf-mmap
[205.410850] Subtest dmabuf-mmap: SUCCESS (0.014s)
[205.472012] [153/171] (801s left) vgem_basic (mmap)
[205.564198] Starting subtest: mmap
[205.572995] Subtest mmap: SUCCESS (0.009s)
[205.622220] [154/171] (800s left) vgem_basic (second-client)
[205.714179] Starting subtest: second-client
[205.747519] Subtest second-client: SUCCESS (0.033s)
[205.830972] [155/171] (800s left) vgem_basic (sysfs)
[205.947432] Starting subtest: sysfs
[205.948591] Subtest sysfs: SUCCESS (0.000s)
[206.006508] [156/171] (800s left) core_hotunplug (unbind-rebind)
[206.130388] Starting subtest: unbind-rebind
[208.960472] Subtest unbind-rebind: SUCCESS (2.830s)
[208.982203] [157/171] (797s left) vgem_basic (unload)
[209.062468] Starting subtest: unload
[238.052614] Subtest unload: SUCCESS (28.955s)
[238.133216] [158/171] (768s left) i915_module_load (reload)
[238.220052] Starting subtest: reload
[242.028675] Subtest reload: SUCCESS (3.809s)
[242.048278] [159/171] (764s left) gem_lmem_swapping (basic)
[245.990059] Starting subtest: basic
[245.990942] Starting dynamic subtest: lmem0
[273.746298] Dynamic subtest lmem0: SUCCESS (27.746s)
[273.747353] Subtest basic: SUCCESS (27.747s)
[276.741586] [160/171] (729s left) gem_lmem_swapping (parallel-random-engines)
[277.675281] Starting subtest: parallel-random-engines
[277.676310] Starting dynamic subtest: lmem0
[279.152461] Dynamic subtest lmem0: SUCCESS (1.475s)
[279.153374] Subtest parallel-random-engines: SUCCESS (1.476s)
[280.777807] [161/171] (725s left) gem_lmem_swapping (random-engines)
[281.620186] Starting subtest: random-engines
[281.621194] Starting dynamic subtest: lmem0
[282.855573] Dynamic subtest lmem0: SUCCESS (1.226s)
[282.856531] Subtest random-engines: SUCCESS (1.227s)
[284.527803] [162/171] (722s left) gem_lmem_swapping (verify-random)
[285.487793] Starting subtest: verify-random
[285.488844] Starting dynamic subtest: lmem0
[296.431987] Dynamic subtest lmem0: SUCCESS (10.935s)
[296.433147] Subtest verify-random: SUCCESS (10.936s)
[298.048141] [163/171] (708s left) i915_pm_rpm (module-reload)
[300.793658] Starting subtest: module-reload
[316.076364] Subtest module-reload: SUCCESS (15.274s)
[316.089357] [164/171] (690s left) i915_selftest (live)
[316.185314] Starting subtest: live
[316.186399] Starting dynamic subtest: sanitycheck
[318.294389] Dynamic subtest sanitycheck: SUCCESS (2.100s)
[318.301119] Starting dynamic subtest: uncore
[320.412521] Dynamic subtest uncore: SUCCESS (2.117s)
[320.420572] Starting dynamic subtest: workarounds
[325.017358] Dynamic subtest workarounds: SUCCESS (4.604s)
[325.024055] Starting dynamic subtest: gt_engines
[328.178488] Dynamic subtest gt_engines: SUCCESS (3.160s)
[328.185143] Starting dynamic subtest: gt_timelines
[364.011302] Dynamic subtest gt_timelines: SUCCESS (35.832s)
[364.018054] Starting dynamic subtest: gt_contexts
[366.182792] Dynamic subtest gt_contexts: SUCCESS (2.171s)
[366.196380] Starting dynamic subtest: gt_lrc
[375.353460] Dynamic subtest gt_lrc: SUCCESS (9.170s)
[375.360586] Starting dynamic subtest: gt_mocs
[379.407400] Dynamic subtest gt_mocs: SUCCESS (4.053s)
[379.413466] Starting dynamic subtest: gt_pm
[382.448469] Dynamic subtest gt_pm: SUCCESS (3.040s)
[382.455299] Starting dynamic subtest: gt_heartbeat
[384.752690] Dynamic subtest gt_heartbeat: SUCCESS (2.303s)
[384.760279] Starting dynamic subtest: gt_tlb
[401.322493] Dynamic subtest gt_tlb: SUCCESS (16.569s)
[401.329715] Starting dynamic subtest: requests
[419.579086] Dynamic subtest requests: SUCCESS (18.254s)
[419.586278] Starting dynamic subtest: migrate
[425.096957] Dynamic subtest migrate: SUCCESS (5.517s)
[425.103807] Starting dynamic subtest: active
[427.218325] Dynamic subtest active: SUCCESS (2.122s)
[427.228151] Starting dynamic subtest: objects
[430.656378] Dynamic subtest objects: SUCCESS (3.437s)
[430.664827] Starting dynamic subtest: mman
[441.846143] Dynamic subtest mman: SUCCESS (11.189s)
[441.854169] Starting dynamic subtest: dmabuf
[443.974110] Dynamic subtest dmabuf: SUCCESS (2.127s)
[443.981444] Starting dynamic subtest: vma
[446.065142] Dynamic subtest vma: SUCCESS (2.090s)
[446.072686] Starting dynamic subtest: coherency
[450.093259] Dynamic subtest coherency: SUCCESS (4.027s)
[450.099384] Starting dynamic subtest: gtt
[460.842222] Dynamic subtest gtt: SUCCESS (10.747s)
[460.849793] Starting dynamic subtest: gem
[462.947471] Dynamic subtest gem: SUCCESS (2.105s)
[462.954656] Starting dynamic subtest: evict
[467.579212] Dynamic subtest evict: SUCCESS (4.631s)
[467.586094] Starting dynamic subtest: hugepages
[485.283365] Dynamic subtest hugepages: SUCCESS (17.703s)
[485.290540] Starting dynamic subtest: gem_contexts
[532.498525] Dynamic subtest gem_contexts: SUCCESS (47.213s)
[532.505031] Starting dynamic subtest: client
[534.695622] Dynamic subtest client: SUCCESS (2.198s)
[534.702811] Starting dynamic subtest: gem_migrate
[539.897287] Dynamic subtest gem_migrate: SUCCESS (5.201s)
[539.904061] Starting dynamic subtest: reset
[542.042330] Dynamic subtest reset: SUCCESS (2.144s)
[542.048775] Starting dynamic subtest: memory_region
[545.674546] Dynamic subtest memory_region: SUCCESS (3.631s)
[545.681447] Starting dynamic subtest: hangcheck
[596.538327] Dynamic subtest hangcheck: SUCCESS (50.863s)
[596.545381] Starting dynamic subtest: execlists
[598.645485] Dynamic subtest execlists: SUCCESS (2.106s)
[598.652462] Starting dynamic subtest: ring_submission
[600.727509] Dynamic subtest ring_submission: SUCCESS (2.081s)
[600.735164] Starting dynamic subtest: perf
[602.962424] Dynamic subtest perf: SUCCESS (2.234s)
[602.969240] Starting dynamic subtest: slpc
[612.919407] Dynamic subtest slpc: SUCCESS (9.956s)
[612.929524] Starting dynamic subtest: guc
[616.580324] Dynamic subtest guc: SUCCESS (3.660s)
[616.587117] Starting dynamic subtest: guc_multi_lrc
[618.757465] Dynamic subtest guc_multi_lrc: SUCCESS (2.176s)
[618.765869] Starting dynamic subtest: guc_hang
[621.591853] Dynamic subtest guc_hang: SUCCESS (2.834s)
[621.598758] Starting dynamic subtest: late_gt_pm
[623.781536] Dynamic subtest late_gt_pm: SUCCESS (2.188s)
[623.782898] Subtest live: SUCCESS (307.587s)
[624.260710] [165/171] (382s left) dmabuf (all-tests)
[624.346160] Starting subtest: all-tests
[624.347392] Starting dynamic subtest: sanitycheck
[624.417717] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[624.431049] Starting dynamic subtest: dma_fence
[624.598754] Dynamic subtest dma_fence: SUCCESS (0.180s)
[624.616307] Starting dynamic subtest: dma_fence_chain
[638.535926] Dynamic subtest dma_fence_chain: SUCCESS (13.928s)
[638.542466] Starting dynamic subtest: dma_fence_unwrap
[638.617535] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[638.636794] Starting dynamic subtest: dma_resv
[638.700585] Dynamic subtest dma_resv: SUCCESS (0.081s)
[638.701929] Subtest all-tests: SUCCESS (14.354s)
[638.733238] [166/171] (368s left) i915_suspend (basic-s2idle-without-i915)
[638.838570] Starting subtest: basic-s2idle-without-i915
[659.519815] Subtest basic-s2idle-without-i915: SUCCESS (5.772s)
[659.736056] [167/171] (362s left) i915_suspend (basic-s3-without-i915)
[659.817081] Starting subtest: basic-s3-without-i915
[662.634158] Subtest basic-s3-without-i915: SKIP (2.802s)
[663.522638] [168/171] (358s left) gem_exec_suspend (basic-s0)
[663.643688] Starting subtest: basic-S0
[663.644696] Starting dynamic subtest: smem
[684.299963] Dynamic subtest smem: SUCCESS (5.846s)
[684.314889] Starting dynamic subtest: lmem0
[704.311125] Dynamic subtest lmem0: SUCCESS (5.799s)
[704.313501] Subtest basic-S0: SUCCESS (11.649s)
[704.521142] [169/171] (346s left) gem_exec_suspend (basic-s3)
[704.635395] Starting subtest: basic-S3
[704.636513] Starting dynamic subtest: smem
[725.299363] Dynamic subtest smem: SUCCESS (5.757s)
[725.309972] Starting dynamic subtest: lmem0
[745.292308] Dynamic subtest lmem0: SUCCESS (5.800s)
[745.293558] Subtest basic-S3: SUCCESS (11.559s)
[745.458806] [170/171] (334s left) kms_chamelium_hpd (common-hpd-after-suspend)
[745.711685] Subtest common-hpd-after-suspend: SKIP (0.000s)
[745.860849] [171/171] (334s left) kms_pipe_crc_basic (suspend-read-crc)
[746.018718] Starting subtest: suspend-read-crc
[746.021376] Starting dynamic subtest: pipe-A-DP-1
[748.552159] Dynamic subtest pipe-A-DP-1: SUCCESS (2.532s)
[748.562472] Starting dynamic subtest: pipe-B-DP-1
[766.678239] Dynamic subtest pipe-B-DP-1: SUCCESS (2.891s)
[766.689163] Starting dynamic subtest: pipe-C-DP-1
[784.749454] Dynamic subtest pipe-C-DP-1: SUCCESS (3.034s)
[784.760351] Starting dynamic subtest: pipe-D-DP-1
[802.813650] Dynamic subtest pipe-D-DP-1: SUCCESS (3.179s)
[802.814673] Subtest suspend-read-crc: SUCCESS (11.647s)
[802.976891] Closing watchdogs
Done.