[42.501873] Initializing watchdogs
[42.502168]   /dev/watchdog0
[42.513820] [001/165] (960s left) i915_module_load (load)
[42.588502] Starting subtest: load
[43.596499] Subtest load: SUCCESS (1.006s)
[43.620061] [002/165] (959s left) core_auth (basic-auth)
[43.699675] Starting subtest: basic-auth
[43.700858] Subtest basic-auth: SUCCESS (0.001s)
[43.783145] [003/165] (959s left) debugfs_test (read_all_entries)
[43.885303] Starting subtest: read_all_entries
[43.970611] Subtest read_all_entries: SUCCESS (0.088s)
[44.072078] [004/165] (959s left) debugfs_test (basic-hwmon)
[44.151418] Starting subtest: basic-hwmon
[44.153444] Subtest basic-hwmon: SKIP (0.000s)
[44.278996] [005/165] (958s left) fbdev (eof)
[44.358665] Starting subtest: eof
[44.359783] Subtest eof: SUCCESS (0.001s)
[44.430242] [006/165] (958s left) fbdev (info)
[44.494496] Starting subtest: info
[44.495458] Subtest info: SUCCESS (0.000s)
[44.561689] [007/165] (958s left) fbdev (nullptr)
[44.640521] Starting subtest: nullptr
[44.641591] Subtest nullptr: SUCCESS (0.000s)
[44.697629] [008/165] (958s left) fbdev (read)
[44.773439] Starting subtest: read
[45.621400] Subtest read: SUCCESS (0.839s)
[45.662438] [009/165] (957s left) fbdev (write)
[45.740928] Starting subtest: write
[46.172047] Subtest write: SUCCESS (0.422s)
[46.213440] [010/165] (956s left) gem_basic (bad-close)
[46.284194] Starting subtest: bad-close
[46.286068] Subtest bad-close: SUCCESS (0.000s)
[46.346193] [011/165] (956s left) gem_basic (create-close)
[46.416360] Starting subtest: create-close
[46.418362] Subtest create-close: SUCCESS (0.000s)
[46.527182] [012/165] (956s left) gem_basic (create-fd-close)
[46.632466] Starting subtest: create-fd-close
[46.634415] Subtest create-fd-close: SUCCESS (0.000s)
[46.757901] [013/165] (956s left) gem_busy (busy@all-engines)
[46.845017] Starting subtest: busy
[46.845997] Starting dynamic subtest: all-engines
[46.901675] Dynamic subtest all-engines: SUCCESS (0.057s)
[46.902696] Subtest busy: SUCCESS (0.057s)
[47.295973] [014/165] (956s left) gem_close_race (basic-process)
[47.385191] Starting subtest: basic-process
[47.452351] Subtest basic-process: SUCCESS (0.069s)
[47.696883] [015/165] (955s left) gem_close_race (basic-threads)
[47.785396] Starting subtest: basic-threads
[48.933607] Subtest basic-threads: SUCCESS (1.150s)
[49.222306] [016/165] (954s left) gem_ctx_create (basic)
[49.309613] Starting subtest: basic
[49.310556] Subtest basic: SUCCESS (0.000s)
[49.593963] [017/165] (953s left) gem_ctx_create (basic-files)
[49.702174] Starting subtest: basic-files
[51.726196] Subtest basic-files: SUCCESS (2.024s)
[52.005355] [018/165] (951s left) gem_ctx_exec (basic)
[52.081618] Starting subtest: basic
[52.088294] Subtest basic: SUCCESS (0.007s)
[52.233365] [019/165] (951s left) gem_exec_basic (basic)
[52.313148] Starting subtest: basic
[52.314306] Starting dynamic subtest: rcs0-smem
[52.315357] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[52.323869] Starting dynamic subtest: bcs0-smem
[52.324914] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[52.332211] Starting dynamic subtest: vcs0-smem
[52.333598] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[52.340733] Starting dynamic subtest: vecs0-smem
[52.342056] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.343396] Subtest basic: SUCCESS (0.006s)
[52.573136] [020/165] (950s left) gem_exec_create (basic)
[52.660376] Starting subtest: basic
[52.661456] Starting dynamic subtest: smem
[54.702676] Dynamic subtest smem: SUCCESS (2.044s)
[54.703682] Subtest basic: SUCCESS (2.044s)
[54.939765] [021/165] (948s left) gem_exec_fence (basic-busy)
[55.190143] Starting subtest: basic-busy
[55.191626] Starting dynamic subtest: rcs0
[55.214695] Dynamic subtest rcs0: SUCCESS (0.024s)
[55.226420] Starting dynamic subtest: bcs0
[55.240749] Dynamic subtest bcs0: SUCCESS (0.025s)
[55.252354] Starting dynamic subtest: vcs0
[55.270705] Dynamic subtest vcs0: SUCCESS (0.030s)
[55.283422] Starting dynamic subtest: vecs0
[55.291351] Dynamic subtest vecs0: SUCCESS (0.020s)
[55.292807] Subtest basic-busy: SUCCESS (0.101s)
[56.039855] [022/165] (947s left) gem_exec_fence (basic-wait)
[56.278369] Starting subtest: basic-wait
[56.279540] Starting dynamic subtest: rcs0
[56.305359] Dynamic subtest rcs0: SUCCESS (0.027s)
[56.312852] Starting dynamic subtest: bcs0
[56.328367] Dynamic subtest bcs0: SUCCESS (0.023s)
[56.336271] Starting dynamic subtest: vcs0
[56.353302] Dynamic subtest vcs0: SUCCESS (0.025s)
[56.360813] Starting dynamic subtest: vecs0
[56.374378] Dynamic subtest vecs0: SUCCESS (0.021s)
[56.375691] Subtest basic-wait: SUCCESS (0.096s)
[57.048367] [023/165] (946s left) gem_exec_fence (basic-await)
[57.278325] Starting subtest: basic-await
[57.279679] Starting dynamic subtest: rcs0
[57.377307] Dynamic subtest rcs0: SUCCESS (0.099s)
[57.385709] Starting dynamic subtest: bcs0
[57.473946] Dynamic subtest bcs0: SUCCESS (0.096s)
[57.482081] Starting dynamic subtest: vcs0
[57.572185] Dynamic subtest vcs0: SUCCESS (0.098s)
[57.581400] Starting dynamic subtest: vecs0
[57.676789] Dynamic subtest vecs0: SUCCESS (0.104s)
[57.678110] Subtest basic-await: SUCCESS (0.399s)
[58.416668] [024/165] (945s left) gem_exec_fence (nb-await)
[58.658771] Starting subtest: nb-await
[58.660161] Starting dynamic subtest: rcs0
[58.729531] Dynamic subtest rcs0: SUCCESS (0.070s)
[58.751245] Starting dynamic subtest: bcs0
[58.810108] Dynamic subtest bcs0: SUCCESS (0.078s)
[58.855608] Starting dynamic subtest: vcs0
[58.917909] Dynamic subtest vcs0: SUCCESS (0.106s)
[58.961487] Starting dynamic subtest: vecs0
[59.021356] Dynamic subtest vecs0: SUCCESS (0.102s)
[59.025495] Subtest nb-await: SUCCESS (0.360s)
[59.791568] [025/165] (943s left) gem_exec_gttfill (basic)
[59.880197] Starting subtest: basic
[69.213023] Subtest basic: SUCCESS (9.324s)
[69.398397] [026/165] (934s left) gem_exec_parallel (engines)
[69.533356] Starting subtest: engines
[69.534331] Starting dynamic subtest: basic
[71.889612] Dynamic subtest basic: SUCCESS (2.359s)
[71.898218] Starting dynamic subtest: contexts
[75.442036] Dynamic subtest contexts: SUCCESS (3.543s)
[75.450842] Starting dynamic subtest: fds
[82.576179] Dynamic subtest fds: SUCCESS (7.142s)
[82.585568] Starting dynamic subtest: userptr
[84.743206] Dynamic subtest userptr: SUCCESS (2.168s)
[84.744305] Subtest engines: SUCCESS (15.212s)
[84.982390] [027/165] (918s left) gem_exec_store (basic)
[85.070466] Starting subtest: basic
[85.119897] Subtest basic: SUCCESS (0.049s)
[85.355651] [028/165] (918s left) gem_flink_basic (bad-flink)
[85.426769] Starting subtest: bad-flink
[85.427921] Subtest bad-flink: SUCCESS (0.000s)
[85.487478] [029/165] (918s left) gem_flink_basic (bad-open)
[85.563149] Starting subtest: bad-open
[85.564124] Subtest bad-open: SUCCESS (0.000s)
[85.639212] [030/165] (918s left) gem_flink_basic (basic)
[85.714858] Starting subtest: basic
[85.716038] Subtest basic: SUCCESS (0.000s)
[85.824500] [031/165] (917s left) gem_flink_basic (double-flink)
[85.900485] Starting subtest: double-flink
[85.901584] Subtest double-flink: SUCCESS (0.000s)
[86.042152] [032/165] (917s left) gem_flink_basic (flink-lifetime)
[86.113686] Starting subtest: flink-lifetime
[86.115767] Subtest flink-lifetime: SUCCESS (0.002s)
[86.241761] [033/165] (917s left) gem_huc_copy (huc-copy)
[86.319704] Starting subtest: huc-copy
[86.321878] Subtest huc-copy: SKIP (0.000s)
[86.456382] [034/165] (917s left) gem_linear_blits (basic)
[86.655021] Starting subtest: basic
[86.663509] Subtest basic: SUCCESS (0.010s)
[86.827300] [035/165] (916s left) gem_mmap (basic)
[86.948777] Starting subtest: basic
[86.953126] Subtest basic: SUCCESS (0.000s)
[87.029500] [036/165] (916s left) gem_mmap_gtt (basic)
[87.103518] Starting subtest: basic
[87.104448] Subtest basic: SUCCESS (0.001s)
[87.161507] [037/165] (916s left) gem_render_linear_blits (basic)
[87.240123] Starting subtest: basic
[87.281666] Subtest basic: SUCCESS (0.042s)
[87.328903] [038/165] (916s left) gem_render_tiled_blits (basic)
[87.405088] Starting subtest: basic
[87.453047] Subtest basic: SUCCESS (0.045s)
[87.494612] [039/165] (916s left) gem_ringfill (basic-all)
[87.758991] Starting subtest: basic-all
[88.925946] Subtest basic-all: SUCCESS (1.158s)
[89.027051] [040/165] (914s left) gem_softpin (allocator-basic)
[89.115965] Starting subtest: allocator-basic
[89.255635] Subtest allocator-basic: SUCCESS (0.131s)
[89.394269] [041/165] (914s left) gem_softpin (allocator-basic-reserve)
[89.472272] Starting subtest: allocator-basic-reserve
[89.620565] Subtest allocator-basic-reserve: SUCCESS (0.140s)
[89.755959] [042/165] (914s left) gem_softpin (safe-alignment)
[89.838091] Starting subtest: safe-alignment
[89.853480] Subtest safe-alignment: SUCCESS (0.015s)
[89.994507] [043/165] (913s left) gem_sync (basic-all)
[90.081791] Starting subtest: basic-all
[92.428807] Subtest basic-all: SUCCESS (2.336s)
[92.643592] [044/165] (911s left) gem_sync (basic-each)
[92.730267] Starting subtest: basic-each
[94.886463] Subtest basic-each: SUCCESS (2.156s)
[95.172108] [045/165] (908s left) gem_tiled_blits (basic)
[95.355714] Starting subtest: basic
[95.379330] Subtest basic: SUCCESS (0.023s)
[95.536916] [046/165] (908s left) gem_tiled_fence_blits (basic)
[95.774083] Starting subtest: basic
[95.787632] Subtest basic: SUCCESS (0.014s)
[95.939945] [047/165] (908s left) gem_tiled_pread_basic
[96.313619] [048/165] (907s left) gem_wait (busy@all-engines)
[96.415337] Starting subtest: busy
[96.416654] Starting dynamic subtest: all-engines
[96.951264] Dynamic subtest all-engines: SUCCESS (0.539s)
[96.952341] Subtest busy: SUCCESS (0.539s)
[97.219498] [049/165] (906s left) gem_wait (wait@all-engines)
[97.311300] Starting subtest: wait
[97.312441] Starting dynamic subtest: all-engines
[98.360330] Dynamic subtest all-engines: SUCCESS (1.044s)
[98.362983] Subtest wait: SUCCESS (1.045s)
[98.666087] [050/165] (905s left) i915_getparams_basic (basic-eu-total)
[98.740185] Starting subtest: basic-eu-total
[98.742126] Subtest basic-eu-total: SUCCESS (0.000s)
[98.805257] [051/165] (905s left) i915_getparams_basic (basic-subslice-total)
[98.880321] Starting subtest: basic-subslice-total
[98.882409] Subtest basic-subslice-total: SUCCESS (0.000s)
[98.956451] [052/165] (905s left) i915_hangman (error-state-basic)
[99.039503] Starting subtest: error-state-basic
[99.047214] Subtest error-state-basic: SUCCESS (0.008s)
[99.119354] [053/165] (905s left) i915_pciid
[99.254180] [054/165] (904s left) kms_addfb_basic (addfb25-4-tiled)
[99.366076] Starting subtest: addfb25-4-tiled
[99.367177] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[99.494038] [055/165] (904s left) kms_addfb_basic (addfb25-bad-modifier)
[99.581075] Starting subtest: addfb25-bad-modifier
[99.582149] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[99.719976] [056/165] (904s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[99.797157] Starting subtest: addfb25-framebuffer-vs-set-tiling
[99.798187] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[99.970545] [057/165] (904s left) kms_addfb_basic (addfb25-modifier-no-flag)
[100.044678] Starting subtest: addfb25-modifier-no-flag
[100.045781] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[100.199111] [058/165] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[100.273526] Starting subtest: addfb25-x-tiled-legacy
[100.274823] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[100.428803] [059/165] (903s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[100.500281] Starting subtest: addfb25-x-tiled-mismatch-legacy
[100.501192] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[100.641203] [060/165] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[100.754058] Starting subtest: addfb25-yf-tiled-legacy
[100.755177] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[100.855565] [061/165] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[100.973332] Starting subtest: addfb25-y-tiled-legacy
[100.974245] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[101.077562] [062/165] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[101.189385] Starting subtest: addfb25-y-tiled-small-legacy
[101.190428] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[101.310359] [063/165] (903s left) kms_addfb_basic (bad-pitch-0)
[101.393300] Starting subtest: bad-pitch-0
[101.394303] Subtest bad-pitch-0: SUCCESS (0.000s)
[101.564822] [064/165] (902s left) kms_addfb_basic (bad-pitch-1024)
[101.637804] Starting subtest: bad-pitch-1024
[101.638939] Subtest bad-pitch-1024: SUCCESS (0.000s)
[101.778994] [065/165] (902s left) kms_addfb_basic (bad-pitch-128)
[101.856312] Starting subtest: bad-pitch-128
[101.857256] Subtest bad-pitch-128: SUCCESS (0.000s)
[102.000241] [066/165] (902s left) kms_addfb_basic (bad-pitch-256)
[102.072159] Starting subtest: bad-pitch-256
[102.073126] Subtest bad-pitch-256: SUCCESS (0.000s)
[102.203192] [067/165] (902s left) kms_addfb_basic (bad-pitch-32)
[102.277992] Starting subtest: bad-pitch-32
[102.279124] Subtest bad-pitch-32: SUCCESS (0.000s)
[102.432149] [068/165] (902s left) kms_addfb_basic (bad-pitch-63)
[102.516225] Starting subtest: bad-pitch-63
[102.517160] Subtest bad-pitch-63: SUCCESS (0.000s)
[102.679590] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536)
[102.764163] Starting subtest: bad-pitch-65536
[102.765103] Subtest bad-pitch-65536: SUCCESS (0.000s)
[102.901450] [070/165] (901s left) kms_addfb_basic (bad-pitch-999)
[102.975194] Starting subtest: bad-pitch-999
[102.976078] Subtest bad-pitch-999: SUCCESS (0.000s)
[103.117770] [071/165] (901s left) kms_addfb_basic (basic)
[103.189527] Starting subtest: basic
[103.190642] Subtest basic: SUCCESS (0.000s)
[103.332185] [072/165] (901s left) kms_addfb_basic (basic-x-tiled-legacy)
[103.415352] Starting subtest: basic-x-tiled-legacy
[103.416367] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[103.569407] [073/165] (901s left) kms_addfb_basic (basic-y-tiled-legacy)
[103.642397] Starting subtest: basic-y-tiled-legacy
[103.643512] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[103.807392] [074/165] (900s left) kms_addfb_basic (bo-too-small)
[103.916479] Starting subtest: bo-too-small
[103.917586] Subtest bo-too-small: SUCCESS (0.000s)
[104.017540] [075/165] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[104.127851] Starting subtest: bo-too-small-due-to-tiling
[104.128943] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[104.234784] [076/165] (900s left) kms_addfb_basic (clobberred-modifier)
[104.315752] Starting subtest: clobberred-modifier
[104.317053] Subtest clobberred-modifier: SUCCESS (0.000s)
[104.468441] [077/165] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[104.542590] Starting subtest: framebuffer-vs-set-tiling
[104.543524] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[104.696482] [078/165] (900s left) kms_addfb_basic (invalid-get-prop)
[104.774964] Starting subtest: invalid-get-prop
[104.776139] Subtest invalid-get-prop: SUCCESS (0.000s)
[104.931035] [079/165] (899s left) kms_addfb_basic (invalid-get-prop-any)
[105.000449] Starting subtest: invalid-get-prop-any
[105.001539] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[105.146992] [080/165] (899s left) kms_addfb_basic (invalid-set-prop)
[105.228284] Starting subtest: invalid-set-prop
[105.229346] Subtest invalid-set-prop: SUCCESS (0.000s)
[105.369545] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any)
[105.444585] Starting subtest: invalid-set-prop-any
[105.445465] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[105.581850] [082/165] (899s left) kms_addfb_basic (no-handle)
[105.655531] Starting subtest: no-handle
[105.656653] Subtest no-handle: SUCCESS (0.000s)
[105.816521] [083/165] (899s left) kms_addfb_basic (size-max)
[105.944104] Starting subtest: size-max
[105.945164] Subtest size-max: SUCCESS (0.000s)
[106.048418] [084/165] (898s left) kms_addfb_basic (small-bo)
[106.156778] Starting subtest: small-bo
[106.157841] Subtest small-bo: SUCCESS (0.000s)
[106.254128] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch)
[106.326639] Starting subtest: tile-pitch-mismatch
[106.327596] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[106.470927] [086/165] (898s left) kms_addfb_basic (too-high)
[106.580788] Starting subtest: too-high
[106.581980] Subtest too-high: SUCCESS (0.001s)
[106.691339] [087/165] (898s left) kms_addfb_basic (too-wide)
[106.809189] Starting subtest: too-wide
[106.810326] Subtest too-wide: SUCCESS (0.000s)
[106.920089] [088/165] (898s left) kms_addfb_basic (unused-handle)
[107.006059] Starting subtest: unused-handle
[107.007101] Subtest unused-handle: SUCCESS (0.000s)
[107.140934] [089/165] (897s left) kms_addfb_basic (unused-modifier)
[107.214546] Starting subtest: unused-modifier
[107.215681] Subtest unused-modifier: SUCCESS (0.000s)
[107.349909] [090/165] (897s left) kms_addfb_basic (unused-offsets)
[107.427410] Starting subtest: unused-offsets
[107.428508] Subtest unused-offsets: SUCCESS (0.000s)
[107.577994] [091/165] (897s left) kms_addfb_basic (unused-pitches)
[107.663154] Starting subtest: unused-pitches
[107.664045] Subtest unused-pitches: SUCCESS (0.000s)
[107.796026] [092/165] (897s left) kms_busy (basic)
[107.911571] Starting subtest: basic
[107.914061] Starting dynamic subtest: flip
[108.843186] Dynamic subtest flip: SUCCESS (0.928s)
[108.859351] Starting dynamic subtest: modeset
[112.648687] Dynamic subtest modeset: SUCCESS (3.804s)
[112.650588] Subtest basic: SUCCESS (4.735s)
[113.556788] [093/165] (891s left) kms_prop_blob (basic)
[113.629114] Starting subtest: basic
[113.630119] Subtest basic: SUCCESS (0.000s)
[113.689021] [094/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[113.800235] Starting subtest: basic-busy-flip-before-cursor-atomic
[113.802140] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[113.895340] [095/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[114.004019] Starting subtest: basic-busy-flip-before-cursor-legacy
[114.006063] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[114.106856] [096/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[114.226230] Starting subtest: basic-flip-after-cursor-atomic
[115.504850] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.277s)
[116.417765] [097/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[116.524738] Starting subtest: basic-flip-after-cursor-legacy
[117.850471] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.323s)
[118.780674] [098/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[118.893370] Starting subtest: basic-flip-after-cursor-varying-size
[120.181396] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.283s)
[121.061639] [099/165] (884s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[121.182908] Starting subtest: basic-flip-before-cursor-atomic
[122.458416] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.271s)
[123.402892] [100/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[123.513345] Starting subtest: basic-flip-before-cursor-legacy
[124.806850] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.289s)
[125.701109] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[125.812100] Starting subtest: basic-flip-before-cursor-varying-size
[127.107456] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.290s)
[128.039617] [102/165] (877s left) kms_dsc (dsc-basic)
[128.157341] Subtest dsc-basic: SKIP (0.000s)
[128.190600] [103/165] (877s left) kms_flip (basic-flip-vs-dpms)
[128.280951] Starting subtest: basic-flip-vs-dpms
[128.285739] Starting dynamic subtest: A-eDP1
[131.146808] Dynamic subtest A-eDP1: SUCCESS (2.858s)
[131.182114] Starting dynamic subtest: B-eDP1
[133.575107] Dynamic subtest B-eDP1: SUCCESS (2.419s)
[133.631510] Starting dynamic subtest: C-eDP1
[135.965117] Dynamic subtest C-eDP1: SUCCESS (2.382s)
[135.996580] Subtest basic-flip-vs-dpms: SUCCESS (7.706s)
[136.871260] [104/165] (868s left) kms_flip (basic-flip-vs-modeset)
[136.959080] Starting subtest: basic-flip-vs-modeset
[136.963054] Starting dynamic subtest: A-eDP1
[139.841971] Dynamic subtest A-eDP1: SUCCESS (2.873s)
[139.910193] Starting dynamic subtest: B-eDP1
[142.214418] Dynamic subtest B-eDP1: SUCCESS (2.367s)
[142.282252] Starting dynamic subtest: C-eDP1
[144.606194] Dynamic subtest C-eDP1: SUCCESS (2.372s)
[144.633675] Subtest basic-flip-vs-modeset: SUCCESS (7.667s)
[145.532179] [105/165] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[145.623675] Starting subtest: basic-flip-vs-wf_vblank
[145.627934] Starting dynamic subtest: A-eDP1
[147.926655] Dynamic subtest A-eDP1: SUCCESS (2.298s)
[147.939800] Starting dynamic subtest: B-eDP1
[150.232301] Dynamic subtest B-eDP1: SUCCESS (2.304s)
[150.246318] Starting dynamic subtest: C-eDP1
[152.520510] Dynamic subtest C-eDP1: SUCCESS (2.283s)
[152.522852] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.899s)
[153.851020] [106/165] (851s left) kms_flip (basic-plain-flip)
[153.942943] Starting subtest: basic-plain-flip
[153.947927] Starting dynamic subtest: A-eDP1
[155.959969] Dynamic subtest A-eDP1: SUCCESS (2.010s)
[155.971667] Starting dynamic subtest: B-eDP1
[157.968699] Dynamic subtest B-eDP1: SUCCESS (2.008s)
[157.978363] Starting dynamic subtest: C-eDP1
[160.000484] Dynamic subtest C-eDP1: SUCCESS (2.030s)
[160.003594] Subtest basic-plain-flip: SUCCESS (6.062s)
[161.281432] [107/165] (844s left) kms_force_connector_basic (force-connector-state)
[161.381933] Starting subtest: force-connector-state
[161.870828] Subtest force-connector-state: SUCCESS (0.489s)
[163.205672] [108/165] (842s left) kms_force_connector_basic (force-edid)
[163.307093] Starting subtest: force-edid
[163.343579] Subtest force-edid: SUCCESS (0.037s)
[163.502896] [109/165] (842s left) kms_force_connector_basic (force-load-detect)
[163.601617] Starting subtest: force-load-detect
[163.604612] Subtest force-load-detect: SKIP (0.000s)
[163.754352] [110/165] (841s left) kms_force_connector_basic (prune-stale-modes)
[163.854970] Starting subtest: prune-stale-modes
[163.891646] Subtest prune-stale-modes: SUCCESS (0.035s)
[164.055912] [111/165] (841s left) kms_frontbuffer_tracking (basic)
[164.170766] Starting subtest: basic
[167.144097] Subtest basic: SUCCESS (2.974s)
[167.262828] [112/165] (838s left) kms_hdmi_inject (inject-audio)
[167.643475] Starting subtest: inject-audio
[167.779488] Subtest inject-audio: SUCCESS (0.141s)
[168.574298] [113/165] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[168.689822] Starting subtest: compare-crc-sanitycheck-xr24
[168.692115] Starting dynamic subtest: pipe-A-eDP-1
[169.414907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[169.435563] Starting dynamic subtest: pipe-B-eDP-1
[170.763814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.341s)
[170.783774] Starting dynamic subtest: pipe-C-eDP-1
[172.099829] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.329s)
[172.102237] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.411s)
[173.026534] [114/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[173.135425] Starting subtest: compare-crc-sanitycheck-nv12
[173.136494] Starting dynamic subtest: pipe-A-eDP-1
[173.138478] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[173.150829] Starting dynamic subtest: pipe-B-eDP-1
[173.153075] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[173.164337] Starting dynamic subtest: pipe-C-eDP-1
[173.166178] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[173.168045] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s)
[173.228476] [115/165] (832s left) kms_pipe_crc_basic (hang-read-crc)
[173.342165] Starting subtest: hang-read-crc
[173.343188] Starting dynamic subtest: pipe-A-eDP-1
[175.889646] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[175.955194] Starting dynamic subtest: pipe-B-eDP-1
[179.081505] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.172s)
[179.128176] Starting dynamic subtest: pipe-C-eDP-1
[182.326421] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.224s)
[182.333180] Subtest hang-read-crc: SUCCESS (8.978s)
[183.280313] [116/165] (822s left) kms_pipe_crc_basic (nonblocking-crc)
[183.400804] Starting subtest: nonblocking-crc
[183.401935] Starting dynamic subtest: pipe-A-eDP-1
[184.494899] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.086s)
[184.571115] Starting dynamic subtest: pipe-B-eDP-1
[186.246848] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.732s)
[186.311507] Starting dynamic subtest: pipe-C-eDP-1
[188.041121] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.770s)
[188.044749] Subtest nonblocking-crc: SUCCESS (4.639s)
[188.970896] [117/165] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[189.095497] Starting subtest: nonblocking-crc-frame-sequence
[189.098665] Starting dynamic subtest: pipe-A-eDP-1
[190.177557] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.076s)
[190.245519] Starting dynamic subtest: pipe-B-eDP-1
[191.983761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.779s)
[192.052681] Starting dynamic subtest: pipe-C-eDP-1
[193.726425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.712s)
[193.730797] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.625s)
[194.648768] [118/165] (811s left) kms_pipe_crc_basic (read-crc)
[194.761300] Starting subtest: read-crc
[194.762361] Starting dynamic subtest: pipe-A-eDP-1
[195.719919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.955s)
[195.769551] Starting dynamic subtest: pipe-B-eDP-1
[197.360677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.615s)
[197.431896] Starting dynamic subtest: pipe-C-eDP-1
[198.955780] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.570s)
[198.960400] Subtest read-crc: SUCCESS (4.192s)
[199.894192] [119/165] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[200.021395] Starting subtest: read-crc-frame-sequence
[200.022441] Starting dynamic subtest: pipe-A-eDP-1
[201.012711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.987s)
[201.081139] Starting dynamic subtest: pipe-B-eDP-1
[202.542785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s)
[202.616965] Starting dynamic subtest: pipe-C-eDP-1
[204.139447] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.580s)
[204.144206] Subtest read-crc-frame-sequence: SUCCESS (4.122s)
[205.016543] [120/165] (800s left) kms_pm_backlight (basic-brightness)
[205.135398] Starting subtest: basic-brightness
[205.234355] Starting dynamic subtest: eDP-1
[205.846689] Dynamic subtest eDP-1: SUCCESS (0.602s)
[205.850452] Subtest basic-brightness: SUCCESS (0.709s)
[206.769153] [121/165] (799s left) kms_pm_rpm (basic-pci-d3-state)
[208.529772] Starting subtest: basic-pci-d3-state
[213.035414] Subtest basic-pci-d3-state: SUCCESS (4.506s)
[213.257665] [122/165] (792s left) kms_pm_rpm (basic-rte)
[213.339578] Starting subtest: basic-rte
[219.520339] Subtest basic-rte: SUCCESS (6.180s)
[224.929919] [123/165] (781s left) kms_psr (primary_page_flip)
[225.044880] Starting subtest: primary_page_flip
[227.122260] Subtest primary_page_flip: SUCCESS (2.073s)
[228.058493] [124/165] (777s left) kms_psr (cursor_plane_move)
[228.173669] Starting subtest: cursor_plane_move
[230.220206] Subtest cursor_plane_move: SUCCESS (2.039s)
[231.152246] [125/165] (774s left) kms_psr (sprite_plane_onoff)
[231.283205] Starting subtest: sprite_plane_onoff
[233.335960] Subtest sprite_plane_onoff: SUCCESS (2.044s)
[234.270263] [126/165] (771s left) kms_psr (primary_mmap_gtt)
[234.399299] Starting subtest: primary_mmap_gtt
[236.421234] Subtest primary_mmap_gtt: SUCCESS (2.018s)
[237.320560] [127/165] (768s left) kms_setmode (basic-clone-single-crtc)
[237.395642] Starting subtest: basic-clone-single-crtc
[237.398926] Subtest basic-clone-single-crtc: SKIP (0.000s)
[237.477197] [128/165] (768s left) i915_pm_rps (basic-api)
[237.559252] Starting subtest: basic-api
[237.564544] Subtest basic-api: SUCCESS (0.005s)
[237.711360] [129/165] (768s left) prime_self_import (basic-llseek-bad)
[237.784133] Starting subtest: basic-llseek-bad
[237.786178] Subtest basic-llseek-bad: SUCCESS (0.002s)
[237.920639] [130/165] (768s left) prime_self_import (basic-llseek-size)
[237.990149] Starting subtest: basic-llseek-size
[237.994810] Subtest basic-llseek-size: SUCCESS (0.003s)
[238.138658] [131/165] (768s left) prime_self_import (basic-with_fd_dup)
[238.213028] Starting subtest: basic-with_fd_dup
[238.215202] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[238.339199] [132/165] (767s left) prime_self_import (basic-with_one_bo)
[238.409811] Starting subtest: basic-with_one_bo
[238.414429] Subtest basic-with_one_bo: SUCCESS (0.004s)
[238.473034] [133/165] (767s left) prime_self_import (basic-with_one_bo_two_files)
[238.543965] Starting subtest: basic-with_one_bo_two_files
[238.548751] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[238.663297] [134/165] (767s left) prime_self_import (basic-with_two_bos)
[238.752615] Starting subtest: basic-with_two_bos
[238.757392] Subtest basic-with_two_bos: SUCCESS (0.003s)
[238.895669] [135/165] (767s left) prime_vgem (basic-fence-flip)
[238.980154] Starting subtest: basic-fence-flip
[239.488717] Subtest basic-fence-flip: SUCCESS (0.492s)
[239.581972] [136/165] (766s left) prime_vgem (basic-fence-mmap)
[239.666359] Starting subtest: basic-fence-mmap
[239.700807] Subtest basic-fence-mmap: SUCCESS (0.039s)
[239.833127] [137/165] (766s left) prime_vgem (basic-fence-read)
[239.954996] Starting subtest: basic-fence-read
[240.023069] Subtest basic-fence-read: SUCCESS (0.068s)
[240.129130] [138/165] (766s left) prime_vgem (basic-gtt)
[240.259172] Starting subtest: basic-gtt
[240.287957] Subtest basic-gtt: SUCCESS (0.019s)
[240.406670] [139/165] (766s left) prime_vgem (basic-read)
[240.533382] Starting subtest: basic-read
[240.559060] Subtest basic-read: SUCCESS (0.030s)
[240.673680] [140/165] (765s left) prime_vgem (basic-write)
[240.765680] Starting subtest: basic-write
[240.790989] Subtest basic-write: SUCCESS (0.030s)
[240.865194] [141/165] (765s left) vgem_basic (setversion)
[240.956257] Starting subtest: setversion
[240.958754] Subtest setversion: SUCCESS (0.000s)
[241.030555] [142/165] (765s left) vgem_basic (create)
[241.122206] Starting subtest: create
[241.123307] Subtest create: SUCCESS (0.000s)
[241.183390] [143/165] (765s left) vgem_basic (debugfs)
[241.280761] Starting subtest: debugfs
[241.281833] Subtest debugfs: SUCCESS (0.000s)
[241.331301] [144/165] (765s left) vgem_basic (dmabuf-export)
[241.414747] Starting subtest: dmabuf-export
[241.416863] Subtest dmabuf-export: SUCCESS (0.002s)
[241.516657] [145/165] (765s left) vgem_basic (dmabuf-fence)
[241.614577] Starting subtest: dmabuf-fence
[241.615573] Subtest dmabuf-fence: SUCCESS (0.001s)
[241.664249] [146/165] (765s left) vgem_basic (dmabuf-fence-before)
[241.750474] Starting subtest: dmabuf-fence-before
[241.751572] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[241.798241] [147/165] (764s left) vgem_basic (dmabuf-mmap)
[241.889384] Starting subtest: dmabuf-mmap
[241.907407] Subtest dmabuf-mmap: SUCCESS (0.018s)
[241.964178] [148/165] (764s left) vgem_basic (mmap)
[242.039047] Starting subtest: mmap
[242.061349] Subtest mmap: SUCCESS (0.013s)
[242.114767] [149/165] (764s left) vgem_basic (second-client)
[242.189236] Starting subtest: second-client
[242.222460] Subtest second-client: SUCCESS (0.033s)
[242.313149] [150/165] (764s left) vgem_basic (sysfs)
[242.389274] Starting subtest: sysfs
[242.390231] Subtest sysfs: SUCCESS (0.001s)
[242.459717] [151/165] (764s left) core_hotunplug (unbind-rebind)
[242.594888] Starting subtest: unbind-rebind
[246.895085] Subtest unbind-rebind: SUCCESS (4.300s)
[246.922243] [152/165] (759s left) vgem_basic (unload)
[246.997907] Starting subtest: unload
[276.102291] Subtest unload: SUCCESS (29.066s)
[276.216489] [153/165] (730s left) i915_module_load (reload)
[276.287676] Starting subtest: reload
[279.438139] Subtest reload: SUCCESS (3.149s)
[279.464616] [154/165] (727s left) gem_lmem_swapping (basic)
[279.605782] Subtest basic: SKIP (0.000s)
[279.656551] [155/165] (727s left) gem_lmem_swapping (parallel-random-engines)
[279.737289] Subtest parallel-random-engines: SKIP (0.000s)
[279.771550] [156/165] (727s left) gem_lmem_swapping (random-engines)
[279.848767] Subtest random-engines: SKIP (0.000s)
[279.888515] [157/165] (727s left) gem_lmem_swapping (verify-random)
[279.966467] Subtest verify-random: SKIP (0.000s)
[280.004875] [158/165] (726s left) i915_pm_rpm (module-reload)
[282.742562] Starting subtest: module-reload
[293.757138] Subtest module-reload: SUCCESS (11.017s)
[293.775135] [159/165] (713s left) i915_selftest (live)
[293.868261] Starting subtest: live
[293.869414] Starting dynamic subtest: sanitycheck
[295.566707] Dynamic subtest sanitycheck: SUCCESS (1.689s)
[295.575105] Starting dynamic subtest: uncore
[297.293786] Dynamic subtest uncore: SUCCESS (1.725s)
[297.306605] Starting dynamic subtest: workarounds
[299.230653] Dynamic subtest workarounds: SUCCESS (1.935s)
[299.238152] Starting dynamic subtest: gt_engines
[301.363546] Dynamic subtest gt_engines: SUCCESS (2.131s)
[301.373856] Starting dynamic subtest: gt_timelines
[311.633753] Dynamic subtest gt_timelines: SUCCESS (10.268s)
[311.641408] Starting dynamic subtest: gt_contexts
[313.503793] Dynamic subtest gt_contexts: SUCCESS (1.869s)
[313.514852] Starting dynamic subtest: gt_lrc
[317.629992] Dynamic subtest gt_lrc: SUCCESS (4.124s)
[317.639464] Starting dynamic subtest: gt_mocs
[319.473728] Dynamic subtest gt_mocs: SUCCESS (1.842s)
[319.481407] Starting dynamic subtest: gt_pm
[325.480726] Dynamic subtest gt_pm: SUCCESS (6.005s)
[325.488449] Starting dynamic subtest: gt_heartbeat
[327.300474] Dynamic subtest gt_heartbeat: SUCCESS (1.821s)
[327.308158] Starting dynamic subtest: gt_tlb
[330.171806] Dynamic subtest gt_tlb: SUCCESS (2.866s)
[330.180369] Starting dynamic subtest: requests
[337.591728] Dynamic subtest requests: SUCCESS (7.418s)
[337.602383] Starting dynamic subtest: migrate
[342.086661] Dynamic subtest migrate: SUCCESS (4.493s)
[342.094993] Starting dynamic subtest: active
[343.774715] Dynamic subtest active: SUCCESS (1.686s)
[343.785182] Starting dynamic subtest: objects
[346.594502] Dynamic subtest objects: SUCCESS (2.818s)
[346.602043] Starting dynamic subtest: mman
[351.754567] Dynamic subtest mman: SUCCESS (5.158s)
[351.761753] Starting dynamic subtest: dmabuf
[353.572713] Dynamic subtest dmabuf: SUCCESS (1.816s)
[353.580707] Starting dynamic subtest: vma
[355.350948] Dynamic subtest vma: SUCCESS (1.775s)
[355.360282] Starting dynamic subtest: coherency
[359.090747] Dynamic subtest coherency: SUCCESS (3.739s)
[359.099943] Starting dynamic subtest: gtt
[367.655697] Dynamic subtest gtt: SUCCESS (8.563s)
[367.664210] Starting dynamic subtest: gem
[369.532720] Dynamic subtest gem: SUCCESS (1.875s)
[369.540464] Starting dynamic subtest: evict
[372.784757] Dynamic subtest evict: SUCCESS (3.250s)
[372.793304] Starting dynamic subtest: hugepages
[379.815757] Dynamic subtest hugepages: SUCCESS (7.028s)
[379.831485] Starting dynamic subtest: gem_contexts
[394.244810] Dynamic subtest gem_contexts: SUCCESS (14.426s)
[394.252626] Starting dynamic subtest: client
[395.998635] Dynamic subtest client: SUCCESS (1.752s)
[396.006515] Starting dynamic subtest: gem_migrate
[397.739704] Dynamic subtest gem_migrate: SUCCESS (1.740s)
[397.747727] Starting dynamic subtest: reset
[400.177656] Dynamic subtest reset: SUCCESS (2.437s)
[400.188260] Starting dynamic subtest: memory_region
[401.856752] Dynamic subtest memory_region: SUCCESS (1.677s)
[401.865073] Starting dynamic subtest: hangcheck
[426.046931] Dynamic subtest hangcheck: SUCCESS (24.188s)
[426.060032] Starting dynamic subtest: execlists
[435.656913] Dynamic subtest execlists: SUCCESS (9.608s)
[435.666592] Starting dynamic subtest: ring_submission
[437.400739] Dynamic subtest ring_submission: SUCCESS (1.742s)
[437.410187] Starting dynamic subtest: perf
[439.330729] Dynamic subtest perf: SUCCESS (1.928s)
[439.342402] Starting dynamic subtest: slpc
[441.067690] Dynamic subtest slpc: SUCCESS (1.735s)
[441.076282] Starting dynamic subtest: guc
[442.749660] Dynamic subtest guc: SUCCESS (1.680s)
[442.757515] Starting dynamic subtest: guc_multi_lrc
[444.480716] Dynamic subtest guc_multi_lrc: SUCCESS (1.729s)
[444.488578] Starting dynamic subtest: guc_hang
[446.176676] Dynamic subtest guc_hang: SUCCESS (1.694s)
[446.187978] Starting dynamic subtest: late_gt_pm
[448.036606] Dynamic subtest late_gt_pm: SUCCESS (1.858s)
[448.037674] Subtest live: SUCCESS (154.160s)
[448.060756] [160/165] (558s left) dmabuf (all-tests)
[448.153067] Starting subtest: all-tests
[448.154526] Starting dynamic subtest: sanitycheck
[448.219179] Dynamic subtest sanitycheck: SUCCESS (0.065s)
[448.259774] Starting dynamic subtest: dma_fence
[448.421688] Dynamic subtest dma_fence: SUCCESS (0.197s)
[448.439124] Starting dynamic subtest: dma_fence_chain
[464.727639] Dynamic subtest dma_fence_chain: SUCCESS (16.293s)
[464.755506] Starting dynamic subtest: dma_fence_unwrap
[464.825217] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s)
[464.864575] Starting dynamic subtest: dma_resv
[464.920715] Dynamic subtest dma_resv: SUCCESS (0.086s)
[464.922387] Subtest all-tests: SUCCESS (16.769s)
[464.967297] [161/165] (542s left) i915_suspend (basic-s2idle-without-i915)
[465.044122] Starting subtest: basic-s2idle-without-i915
[484.459219] Subtest basic-s2idle-without-i915: SUCCESS (4.263s)
[486.900439] [162/165] (537s left) i915_suspend (basic-s3-without-i915)
[486.998128] Starting subtest: basic-s3-without-i915
[507.159358] Subtest basic-s3-without-i915: SUCCESS (4.017s)
[511.045372] [163/165] (532s left) gem_exec_suspend (basic-s0)
[511.153592] Starting subtest: basic-S0
[511.154552] Starting dynamic subtest: smem
[529.458188] Dynamic subtest smem: SUCCESS (3.255s)
[529.460099] Subtest basic-S0: SUCCESS (3.259s)
[533.728080] [164/165] (528s left) gem_exec_suspend (basic-s3)
[533.844262] Starting subtest: basic-S3
[533.845377] Starting dynamic subtest: smem
[554.161383] Dynamic subtest smem: SUCCESS (3.974s)
[554.162506] Subtest basic-S3: SUCCESS (3.976s)
[556.426205] [165/165] (524s left) kms_pipe_crc_basic (suspend-read-crc)
[556.550742] Starting subtest: suspend-read-crc
[556.551936] Starting dynamic subtest: pipe-A-eDP-1
[585.355707] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.402s)
[585.391865] Starting dynamic subtest: pipe-B-eDP-1
[606.393452] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.031s)
[606.430844] Starting dynamic subtest: pipe-C-eDP-1
[627.969875] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.689s)
[627.971763] Subtest suspend-read-crc: SUCCESS (21.160s)
[629.857585] Closing watchdogs
Done.