[40.405377] Initializing watchdogs
[40.405600]   /dev/watchdog0
[40.440957] [001/164] (960s left) i915_module_load (load)
[40.621206] Starting subtest: load
[42.165269] Subtest load: SUCCESS (1.524s)
[42.278977] [002/164] (958s left) core_auth (basic-auth)
[42.507400] Starting subtest: basic-auth
[42.528253] Subtest basic-auth: SUCCESS (0.001s)
[42.614210] [003/164] (958s left) debugfs_test (read_all_entries)
[42.806529] Starting subtest: read_all_entries
[42.827810] Subtest read_all_entries: SUCCESS (0.047s)
[42.947377] [004/164] (958s left) debugfs_test (basic-hwmon)
[43.132241] Starting subtest: basic-hwmon
[43.178479] Subtest basic-hwmon: SKIP (0.000s)
[43.268309] [005/164] (958s left) fbdev (eof)
[43.457434] Starting subtest: eof
[43.482946] Subtest eof: SUCCESS (0.001s)
[43.583028] [006/164] (957s left) fbdev (info)
[43.756930] Starting subtest: info
[43.778112] Subtest info: SUCCESS (0.000s)
[43.887384] [007/164] (957s left) fbdev (nullptr)
[44.042704] Starting subtest: nullptr
[44.065931] Subtest nullptr: SUCCESS (0.000s)
[44.198452] [008/164] (957s left) fbdev (read)
[44.378253] Starting subtest: read
[44.637709] Subtest read: SUCCESS (0.274s)
[44.765859] [009/164] (956s left) fbdev (write)
[44.928497] Starting subtest: write
[45.055314] Subtest write: SUCCESS (0.141s)
[45.154510] [010/164] (956s left) gem_basic (bad-close)
[45.343803] Starting subtest: bad-close
[45.382652] Subtest bad-close: SUCCESS (0.000s)
[45.468961] [011/164] (956s left) gem_basic (create-close)
[45.628857] Starting subtest: create-close
[45.672867] Subtest create-close: SUCCESS (0.000s)
[45.754870] [012/164] (956s left) gem_basic (create-fd-close)
[45.929803] Starting subtest: create-fd-close
[45.972504] Subtest create-fd-close: SUCCESS (0.000s)
[46.046503] [013/164] (955s left) gem_busy (busy@all-engines)
[46.236785] Starting subtest: busy
[46.256508] Starting dynamic subtest: all-engines
[46.275785] Dynamic subtest all-engines: SUCCESS (0.032s)
[46.295409] Subtest busy: SUCCESS (0.033s)
[46.614938] [014/164] (955s left) gem_close_race (basic-process)
[46.812221] Starting subtest: basic-process
[46.853949] Subtest basic-process: SUCCESS (0.059s)
[47.074627] [015/164] (955s left) gem_close_race (basic-threads)
[47.243448] Starting subtest: basic-threads
[48.406231] Subtest basic-threads: SUCCESS (1.178s)
[48.600267] [016/164] (953s left) gem_ctx_create (basic)
[48.777548] Starting subtest: basic
[48.796696] Subtest basic: SUCCESS (0.000s)
[48.983973] [017/164] (953s left) gem_ctx_create (basic-files)
[49.176459] Starting subtest: basic-files
[51.182870] Subtest basic-files: SUCCESS (2.022s)
[51.426304] [018/164] (950s left) gem_ctx_exec (basic)
[51.619186] Starting subtest: basic
[51.638740] Subtest basic: SUCCESS (0.002s)
[51.718434] [019/164] (950s left) gem_exec_basic (basic)
[51.915063] Starting subtest: basic
[51.934714] Starting dynamic subtest: rcs0-smem
[51.956885] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[51.993247] Starting dynamic subtest: vcs0-smem
[52.014205] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[52.035771] Subtest basic: SUCCESS (0.002s)
[52.113454] [020/164] (950s left) gem_exec_create (basic)
[52.301408] Starting subtest: basic
[52.320306] Starting dynamic subtest: smem
[54.327775] Dynamic subtest smem: SUCCESS (2.047s)
[54.349803] Subtest basic: SUCCESS (2.047s)
[54.547317] [021/164] (948s left) gem_exec_fence (basic-busy)
[54.849960] Starting subtest: basic-busy
[54.871381] Starting dynamic subtest: rcs0
[54.915049] Dynamic subtest rcs0: SUCCESS (0.027s)
[54.946698] Starting dynamic subtest: vcs0
[54.985629] Dynamic subtest vcs0: SUCCESS (0.020s)
[55.007197] Subtest basic-busy: SUCCESS (0.047s)
[55.484773] [022/164] (947s left) gem_exec_fence (basic-wait)
[55.824237] Starting subtest: basic-wait
[55.844034] Starting dynamic subtest: rcs0
[55.863636] Dynamic subtest rcs0: SUCCESS (0.014s)
[55.894105] Starting dynamic subtest: vcs0
[55.913287] Dynamic subtest vcs0: SUCCESS (0.024s)
[55.935140] Subtest basic-wait: SUCCESS (0.038s)
[56.356444] [023/164] (946s left) gem_exec_fence (basic-await)
[56.655735] Starting subtest: basic-await
[56.676837] Starting dynamic subtest: rcs0
[56.724568] Dynamic subtest rcs0: SUCCESS (0.070s)
[56.751199] Starting dynamic subtest: vcs0
[56.805789] Dynamic subtest vcs0: SUCCESS (0.078s)
[56.827558] Subtest basic-await: SUCCESS (0.149s)
[57.305611] [024/164] (945s left) gem_exec_fence (nb-await)
[57.614507] Starting subtest: nb-await
[57.633952] Starting dynamic subtest: rcs0
[57.673935] Dynamic subtest rcs0: SUCCESS (0.053s)
[57.711236] Starting dynamic subtest: vcs0
[57.732941] Dynamic subtest vcs0: SUCCESS (0.053s)
[57.754430] Subtest nb-await: SUCCESS (0.107s)
[58.242291] [025/164] (944s left) gem_exec_gttfill (basic)
[58.427497] Starting subtest: basic
[68.241521] Subtest basic: SUCCESS (9.834s)
[68.465923] [026/164] (934s left) gem_exec_parallel (engines)
[68.771580] Starting subtest: engines
[68.795813] Starting dynamic subtest: basic
[70.414173] Dynamic subtest basic: SUCCESS (1.653s)
[70.442050] Starting dynamic subtest: contexts
[72.454448] Dynamic subtest contexts: SUCCESS (2.050s)
[72.482104] Starting dynamic subtest: fds
[72.519853] Dynamic subtest fds: SKIP (0.001s)
[72.547639] Starting dynamic subtest: userptr
[74.257700] Dynamic subtest userptr: SUCCESS (1.788s)
[74.277567] Subtest engines: SUCCESS (5.492s)
[74.461756] [027/164] (928s left) gem_exec_store (basic)
[74.727401] Starting subtest: basic
[74.748709] Subtest basic: SUCCESS (0.041s)
[74.905916] [028/164] (928s left) gem_flink_basic (bad-flink)
[75.082918] Starting subtest: bad-flink
[75.106923] Subtest bad-flink: SUCCESS (0.000s)
[75.196462] [029/164] (927s left) gem_flink_basic (bad-open)
[75.417050] Starting subtest: bad-open
[75.441473] Subtest bad-open: SUCCESS (0.000s)
[75.541560] [030/164] (927s left) gem_flink_basic (basic)
[75.724283] Starting subtest: basic
[75.746546] Subtest basic: SUCCESS (0.000s)
[75.828846] [031/164] (927s left) gem_flink_basic (double-flink)
[76.039737] Starting subtest: double-flink
[76.060270] Subtest double-flink: SUCCESS (0.000s)
[76.151475] [032/164] (927s left) gem_flink_basic (flink-lifetime)
[76.341227] Starting subtest: flink-lifetime
[76.363324] Subtest flink-lifetime: SUCCESS (0.002s)
[76.455577] [033/164] (927s left) gem_huc_copy (huc-copy)
[76.660475] Subtest huc-copy: SKIP (0.000s)
[76.751747] [034/164] (926s left) gem_linear_blits (basic)
[77.027999] Starting subtest: basic
[77.048872] Subtest basic: SUCCESS (0.017s)
[77.221936] [035/164] (926s left) gem_mmap (basic)
[77.524294] Starting subtest: basic
[77.629543] Subtest basic: SUCCESS (0.002s)
[77.710642] [036/164] (926s left) gem_mmap_gtt (basic)
[77.917824] Starting subtest: basic
[77.937355] Subtest basic: SUCCESS (0.002s)
[78.017756] [037/164] (925s left) gem_render_linear_blits (basic)
[78.195660] Starting subtest: basic
[78.301782] Subtest basic: SUCCESS (0.047s)
[78.380427] [038/164] (925s left) gem_render_tiled_blits (basic)
[78.581467] Starting subtest: basic
[78.705313] Subtest basic: SUCCESS (0.048s)
[78.786450] [039/164] (925s left) gem_ringfill (basic-all)
[79.036272] Starting subtest: basic-all
[80.129322] Subtest basic-all: SUCCESS (1.116s)
[80.235599] [040/164] (923s left) gem_softpin (allocator-basic)
[80.452248] Subtest allocator-basic: SKIP (0.000s)
[80.559445] [041/164] (923s left) gem_softpin (allocator-basic-reserve)
[80.757751] Subtest allocator-basic-reserve: SKIP (0.000s)
[80.877632] [042/164] (923s left) gem_softpin (safe-alignment)
[81.111611] Starting subtest: safe-alignment
[81.131191] Subtest safe-alignment: SUCCESS (0.006s)
[81.211500] [043/164] (923s left) gem_sync (basic-all)
[81.438923] Starting subtest: basic-all
[83.476550] Subtest basic-all: SUCCESS (2.081s)
[83.682366] [044/164] (920s left) gem_sync (basic-each)
[83.894213] Starting subtest: basic-each
[85.937350] Subtest basic-each: SUCCESS (2.078s)
[86.153889] [045/164] (918s left) gem_tiled_blits (basic)
[86.382740] Starting subtest: basic
[86.421618] Subtest basic: SUCCESS (0.031s)
[86.563732] [046/164] (918s left) gem_tiled_fence_blits (basic)
[86.973067] Starting subtest: basic
[86.996648] Subtest basic: SUCCESS (0.014s)
[87.139398] [047/164] (917s left) gem_tiled_pread_basic
[87.680728] [048/164] (917s left) gem_wait (busy@all-engines)
[87.857829] Starting subtest: busy
[87.878899] Starting dynamic subtest: all-engines
[88.377087] Dynamic subtest all-engines: SUCCESS (0.513s)
[88.396798] Subtest busy: SUCCESS (0.513s)
[88.637924] [049/164] (916s left) gem_wait (wait@all-engines)
[88.824459] Starting subtest: wait
[88.846333] Starting dynamic subtest: all-engines
[89.853688] Dynamic subtest all-engines: SUCCESS (1.019s)
[89.873208] Subtest wait: SUCCESS (1.019s)
[90.114424] [050/164] (914s left) i915_getparams_basic (basic-eu-total)
[90.295053] Starting subtest: basic-eu-total
[90.337814] Subtest basic-eu-total: SUCCESS (0.000s)
[90.417111] [051/164] (914s left) i915_getparams_basic (basic-subslice-total)
[90.602088] Starting subtest: basic-subslice-total
[90.641054] Subtest basic-subslice-total: SUCCESS (0.000s)
[90.729337] [052/164] (914s left) i915_hangman (error-state-basic)
[90.917061] Starting subtest: error-state-basic
[90.939237] Subtest error-state-basic: SUCCESS (0.004s)
[91.042146] [053/164] (914s left) i915_pciid
[91.350790] [054/164] (913s left) kms_addfb_basic (addfb25-4-tiled)
[91.598375] Starting subtest: addfb25-4-tiled
[91.619120] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[91.723307] [055/164] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[91.905864] Starting subtest: addfb25-bad-modifier
[91.927358] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.010689] [056/164] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.187939] Starting subtest: addfb25-framebuffer-vs-set-tiling
[92.209699] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.289986] [057/164] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[92.477635] Starting subtest: addfb25-modifier-no-flag
[92.497196] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[92.585469] [058/164] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[92.756454] Starting subtest: addfb25-x-tiled-legacy
[92.778335] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[92.862784] [059/164] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[93.037430] Starting subtest: addfb25-x-tiled-mismatch-legacy
[93.059150] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[93.144352] [060/164] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[93.320638] Starting subtest: addfb25-yf-tiled-legacy
[93.340550] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[93.419192] [061/164] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.604935] Starting subtest: addfb25-y-tiled-legacy
[93.633345] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.716644] [062/164] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.901839] Starting subtest: addfb25-y-tiled-small-legacy
[93.945075] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[94.030106] [063/164] (911s left) kms_addfb_basic (bad-pitch-0)
[94.218203] Starting subtest: bad-pitch-0
[94.239921] Subtest bad-pitch-0: SUCCESS (0.000s)
[94.321407] [064/164] (911s left) kms_addfb_basic (bad-pitch-1024)
[94.510393] Starting subtest: bad-pitch-1024
[94.530181] Subtest bad-pitch-1024: SUCCESS (0.000s)
[94.612999] [065/164] (911s left) kms_addfb_basic (bad-pitch-128)
[94.790997] Starting subtest: bad-pitch-128
[94.810435] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.898035] [066/164] (911s left) kms_addfb_basic (bad-pitch-256)
[95.082088] Starting subtest: bad-pitch-256
[95.104029] Subtest bad-pitch-256: SUCCESS (0.000s)
[95.199299] [067/164] (911s left) kms_addfb_basic (bad-pitch-32)
[95.383782] Starting subtest: bad-pitch-32
[95.405275] Subtest bad-pitch-32: SUCCESS (0.000s)
[95.484346] [068/164] (910s left) kms_addfb_basic (bad-pitch-63)
[95.678542] Starting subtest: bad-pitch-63
[95.697861] Subtest bad-pitch-63: SUCCESS (0.000s)
[95.783152] [069/164] (910s left) kms_addfb_basic (bad-pitch-65536)
[95.961864] Starting subtest: bad-pitch-65536
[95.980893] Subtest bad-pitch-65536: SUCCESS (0.001s)
[96.068818] [070/164] (910s left) kms_addfb_basic (bad-pitch-999)
[96.245185] Starting subtest: bad-pitch-999
[96.265238] Subtest bad-pitch-999: SUCCESS (0.000s)
[96.372281] [071/164] (910s left) kms_addfb_basic (basic)
[96.564614] Starting subtest: basic
[96.590645] Subtest basic: SUCCESS (0.000s)
[96.696157] [072/164] (909s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.898718] Starting subtest: basic-x-tiled-legacy
[96.921644] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[97.039436] [073/164] (909s left) kms_addfb_basic (basic-y-tiled-legacy)
[97.264898] Starting subtest: basic-y-tiled-legacy
[97.289800] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[97.411963] [074/164] (909s left) kms_addfb_basic (bo-too-small)
[97.623521] Starting subtest: bo-too-small
[97.645639] Subtest bo-too-small: SUCCESS (0.000s)
[97.738070] [075/164] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[97.936639] Starting subtest: bo-too-small-due-to-tiling
[97.958098] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[98.060747] [076/164] (908s left) kms_addfb_basic (clobberred-modifier)
[98.249681] Starting subtest: clobberred-modifier
[98.274086] Subtest clobberred-modifier: SUCCESS (0.000s)
[98.372724] [077/164] (908s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[98.574739] Starting subtest: framebuffer-vs-set-tiling
[98.598458] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[98.688620] [078/164] (908s left) kms_addfb_basic (invalid-get-prop)
[98.882630] Starting subtest: invalid-get-prop
[98.904553] Subtest invalid-get-prop: SUCCESS (0.000s)
[98.995176] [079/164] (908s left) kms_addfb_basic (invalid-get-prop-any)
[99.194258] Starting subtest: invalid-get-prop-any
[99.216273] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[99.309732] [080/164] (908s left) kms_addfb_basic (invalid-set-prop)
[99.510880] Starting subtest: invalid-set-prop
[99.532469] Subtest invalid-set-prop: SUCCESS (0.000s)
[99.615307] [081/164] (907s left) kms_addfb_basic (invalid-set-prop-any)
[99.804943] Starting subtest: invalid-set-prop-any
[99.825690] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[99.911724] [082/164] (907s left) kms_addfb_basic (no-handle)
[100.101045] Starting subtest: no-handle
[100.120660] Subtest no-handle: SUCCESS (0.000s)
[100.209265] [083/164] (907s left) kms_addfb_basic (size-max)
[100.391713] Starting subtest: size-max
[100.412316] Subtest size-max: SUCCESS (0.000s)
[100.499894] [084/164] (907s left) kms_addfb_basic (small-bo)
[100.691571] Starting subtest: small-bo
[100.713897] Subtest small-bo: SUCCESS (0.000s)
[100.797394] [085/164] (906s left) kms_addfb_basic (tile-pitch-mismatch)
[100.995864] Starting subtest: tile-pitch-mismatch
[101.016077] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[101.097220] [086/164] (906s left) kms_addfb_basic (too-high)
[101.280066] Starting subtest: too-high
[101.299650] Subtest too-high: SUCCESS (0.001s)
[101.389650] [087/164] (906s left) kms_addfb_basic (too-wide)
[101.567212] Starting subtest: too-wide
[101.588325] Subtest too-wide: SUCCESS (0.000s)
[101.675103] [088/164] (906s left) kms_addfb_basic (unused-handle)
[101.861596] Starting subtest: unused-handle
[101.882694] Subtest unused-handle: SUCCESS (0.000s)
[101.970349] [089/164] (906s left) kms_addfb_basic (unused-modifier)
[102.156653] Starting subtest: unused-modifier
[102.179272] Subtest unused-modifier: SUCCESS (0.000s)
[102.259166] [090/164] (905s left) kms_addfb_basic (unused-offsets)
[102.445803] Starting subtest: unused-offsets
[102.464841] Subtest unused-offsets: SUCCESS (0.000s)
[102.546729] [091/164] (905s left) kms_addfb_basic (unused-pitches)
[102.730399] Starting subtest: unused-pitches
[102.751448] Subtest unused-pitches: SUCCESS (0.000s)
[102.835957] [092/164] (905s left) kms_busy (basic)
[103.031437] Starting subtest: basic
[103.053369] Starting dynamic subtest: flip
[103.788182] Dynamic subtest flip: SUCCESS (0.742s)
[103.816481] Starting dynamic subtest: modeset
[104.415506] Dynamic subtest modeset: SUCCESS (0.643s)
[104.436375] Subtest basic: SUCCESS (1.386s)
[104.603937] [093/164] (903s left) kms_prop_blob (basic)
[104.813873] Starting subtest: basic
[104.833254] Subtest basic: SUCCESS (0.000s)
[104.919941] [094/164] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[105.142135] Starting subtest: basic-busy-flip-before-cursor-atomic
[106.132907] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.994s)
[106.307286] [095/164] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[106.487724] Starting subtest: basic-busy-flip-before-cursor-legacy
[107.474291] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.981s)
[107.655691] [096/164] (900s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[107.850062] Starting subtest: basic-flip-after-cursor-atomic
[108.827922] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.976s)
[108.984144] [097/164] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[109.170072] Starting subtest: basic-flip-after-cursor-legacy
[110.127177] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.965s)
[110.298994] [098/164] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[110.495451] Starting subtest: basic-flip-after-cursor-varying-size
[111.471092] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.974s)
[111.627123] [099/164] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[111.807069] Starting subtest: basic-flip-before-cursor-atomic
[112.775248] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.971s)
[112.943394] [100/164] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[113.123581] Starting subtest: basic-flip-before-cursor-legacy
[114.144932] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.006s)
[114.302281] [101/164] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[114.480930] Starting subtest: basic-flip-before-cursor-varying-size
[115.458994] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.975s)
[115.624314] [102/164] (893s left) kms_flip (basic-flip-vs-dpms)
[115.832485] Starting subtest: basic-flip-vs-dpms
[115.853958] Starting dynamic subtest: A-VGA1
[117.094095] Dynamic subtest A-VGA1: SUCCESS (1.291s)
[117.124660] Starting dynamic subtest: B-VGA1
[118.356257] Dynamic subtest B-VGA1: SUCCESS (1.243s)
[118.381878] Subtest basic-flip-vs-dpms: SUCCESS (2.537s)
[118.563160] [103/164] (890s left) kms_flip (basic-flip-vs-modeset)
[118.801319] Starting subtest: basic-flip-vs-modeset
[118.827128] Starting dynamic subtest: A-VGA1
[120.096271] Dynamic subtest A-VGA1: SUCCESS (1.318s)
[120.136175] Starting dynamic subtest: B-VGA1
[121.332976] Dynamic subtest B-VGA1: SUCCESS (1.246s)
[121.354469] Subtest basic-flip-vs-modeset: SUCCESS (2.568s)
[121.515136] [104/164] (887s left) kms_flip (basic-flip-vs-wf_vblank)
[121.714929] Starting subtest: basic-flip-vs-wf_vblank
[121.734127] Starting dynamic subtest: A-VGA1
[123.223157] Dynamic subtest A-VGA1: SUCCESS (1.537s)
[123.253564] Starting dynamic subtest: B-VGA1
[124.725660] Dynamic subtest B-VGA1: SUCCESS (1.506s)
[124.744684] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.047s)
[124.971908] [105/164] (884s left) kms_flip (basic-plain-flip)
[125.185754] Starting subtest: basic-plain-flip
[125.204829] Starting dynamic subtest: A-VGA1
[126.405888] Dynamic subtest A-VGA1: SUCCESS (1.263s)
[126.439923] Starting dynamic subtest: B-VGA1
[127.605226] Dynamic subtest B-VGA1: SUCCESS (1.199s)
[127.629222] Subtest basic-plain-flip: SUCCESS (2.465s)
[127.834434] [106/164] (881s left) kms_force_connector_basic (force-connector-state)
[128.037187] Starting subtest: force-connector-state
[128.142825] Subtest force-connector-state: SUCCESS (0.127s)
[128.386405] [107/164] (881s left) kms_force_connector_basic (force-edid)
[128.568235] Starting subtest: force-edid
[128.588986] Subtest force-edid: SUCCESS (0.023s)
[128.689502] [108/164] (880s left) kms_force_connector_basic (force-load-detect)
[128.882886] Starting subtest: force-load-detect
[129.043458] Subtest force-load-detect: SUCCESS (0.174s)
[129.254583] [109/164] (880s left) kms_force_connector_basic (prune-stale-modes)
[129.434575] Starting subtest: prune-stale-modes
[129.455455] Subtest prune-stale-modes: SUCCESS (0.016s)
[129.554277] [110/164] (880s left) kms_frontbuffer_tracking (basic)
[129.805887] Starting subtest: basic
[131.979412] Subtest basic: SUCCESS (2.243s)
[132.116193] [111/164] (877s left) kms_hdmi_inject (inject-audio)
[132.317375] Starting subtest: inject-audio
[132.481125] Subtest inject-audio: SUCCESS (0.150s)
[132.731474] [112/164] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[132.938862] Starting subtest: compare-crc-sanitycheck-xr24
[132.958394] Starting dynamic subtest: pipe-A-VGA-1
[133.263088] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.320s)
[133.296308] Starting dynamic subtest: pipe-B-VGA-1
[133.613230] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.340s)
[133.634115] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.665s)
[133.789596] [113/164] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[133.971071] Starting subtest: compare-crc-sanitycheck-nv12
[133.990170] Starting dynamic subtest: pipe-A-VGA-1
[134.033084] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[134.068711] Starting dynamic subtest: pipe-B-VGA-1
[134.110336] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[134.149282] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[134.233748] [114/164] (875s left) kms_pipe_crc_basic (hang-read-crc)
[134.427487] Starting subtest: hang-read-crc
[134.448133] Starting dynamic subtest: pipe-A-VGA-1
[135.288860] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.856s)
[135.316910] Starting dynamic subtest: pipe-B-VGA-1
[136.148050] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.863s)
[136.168223] Subtest hang-read-crc: SUCCESS (1.723s)
[136.304781] [115/164] (873s left) kms_pipe_crc_basic (nonblocking-crc)
[136.498744] Starting subtest: nonblocking-crc
[136.519558] Starting dynamic subtest: pipe-A-VGA-1
[136.965981] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.478s)
[136.995555] Starting dynamic subtest: pipe-B-VGA-1
[137.503875] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.527s)
[137.522609] Subtest nonblocking-crc: SUCCESS (1.010s)
[137.673255] [116/164] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[137.862587] Starting subtest: nonblocking-crc-frame-sequence
[137.884722] Starting dynamic subtest: pipe-A-VGA-1
[138.372412] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.505s)
[138.399522] Starting dynamic subtest: pipe-B-VGA-1
[138.864579] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.496s)
[138.885669] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.005s)
[139.022252] [117/164] (871s left) kms_pipe_crc_basic (read-crc)
[139.235797] Starting subtest: read-crc
[139.261922] Starting dynamic subtest: pipe-A-VGA-1
[140.137530] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.431s)
[140.175802] Starting dynamic subtest: pipe-B-VGA-1
[140.202164] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.470s)
[140.227617] Subtest read-crc: SUCCESS (0.906s)
[140.327835] [118/164] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[140.540576] Starting subtest: read-crc-frame-sequence
[140.562619] Starting dynamic subtest: pipe-A-VGA-1
[140.968960] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.431s)
[141.001977] Starting dynamic subtest: pipe-B-VGA-1
[141.372412] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.428s)
[141.399603] Subtest read-crc-frame-sequence: SUCCESS (0.862s)
[141.569518] [119/164] (868s left) kms_pm_backlight (basic-brightness)
[141.833210] Subtest basic-brightness: SKIP (0.000s)
[141.923233] [120/164] (868s left) kms_psr (primary_page_flip)
[142.141466] Subtest primary_page_flip: SKIP (0.000s)
[142.232642] [121/164] (868s left) kms_psr (cursor_plane_move)
[142.438275] Subtest cursor_plane_move: SKIP (0.000s)
[142.520551] [122/164] (868s left) kms_psr (sprite_plane_onoff)
[142.719219] Subtest sprite_plane_onoff: SKIP (0.000s)
[142.796709] [123/164] (868s left) kms_psr (primary_mmap_gtt)
[143.001682] Subtest primary_mmap_gtt: SKIP (0.000s)
[143.087374] [124/164] (867s left) kms_setmode (basic-clone-single-crtc)
[143.278940] Starting subtest: basic-clone-single-crtc
[143.344388] Subtest basic-clone-single-crtc: SKIP (0.000s)
[143.426381] [125/164] (867s left) i915_pm_rpm (basic-pci-d3-state)
[145.021056] Subtest basic-pci-d3-state: SKIP (0.000s)
[145.104509] [126/164] (865s left) i915_pm_rpm (basic-rte)
[145.278152] Starting subtest: basic-rte
[146.917867] Subtest basic-rte: SKIP (1.580s)
[147.040457] [127/164] (864s left) i915_pm_rps (basic-api)
[147.258381] Subtest basic-api: SKIP (0.000s)
[147.340563] [128/164] (863s left) prime_self_import (basic-llseek-bad)
[147.511217] Starting subtest: basic-llseek-bad
[147.550274] Subtest basic-llseek-bad: SUCCESS (0.003s)
[147.638087] [129/164] (863s left) prime_self_import (basic-llseek-size)
[147.810066] Starting subtest: basic-llseek-size
[147.853682] Subtest basic-llseek-size: SUCCESS (0.007s)
[147.938267] [130/164] (863s left) prime_self_import (basic-with_fd_dup)
[148.114597] Starting subtest: basic-with_fd_dup
[148.158450] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[148.239309] [131/164] (863s left) prime_self_import (basic-with_one_bo)
[148.408718] Starting subtest: basic-with_one_bo
[148.447544] Subtest basic-with_one_bo: SUCCESS (0.004s)
[148.544675] [132/164] (863s left) prime_self_import (basic-with_one_bo_two_files)
[148.710569] Starting subtest: basic-with_one_bo_two_files
[148.751519] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[148.836961] [133/164] (862s left) prime_self_import (basic-with_two_bos)
[149.000175] Starting subtest: basic-with_two_bos
[149.043502] Subtest basic-with_two_bos: SUCCESS (0.004s)
[149.123401] [134/164] (862s left) prime_vgem (basic-fence-flip)
[149.337391] Starting subtest: basic-fence-flip
[149.671288] Subtest basic-fence-flip: SUCCESS (0.376s)
[149.805670] [135/164] (861s left) prime_vgem (basic-fence-mmap)
[150.031978] Starting subtest: basic-fence-mmap
[150.052297] Subtest basic-fence-mmap: SUCCESS (0.049s)
[150.156589] [136/164] (861s left) prime_vgem (basic-fence-read)
[150.379992] Starting subtest: basic-fence-read
[150.422689] Subtest basic-fence-read: SUCCESS (0.089s)
[150.527117] [137/164] (861s left) prime_vgem (basic-gtt)
[150.750074] Starting subtest: basic-gtt
[150.769209] Subtest basic-gtt: SUCCESS (0.026s)
[150.876820] [138/164] (861s left) prime_vgem (basic-read)
[151.082491] Starting subtest: basic-read
[151.103577] Subtest basic-read: SUCCESS (0.034s)
[151.201714] [139/164] (860s left) prime_vgem (basic-write)
[151.401868] Starting subtest: basic-write
[151.420921] Subtest basic-write: SUCCESS (0.034s)
[151.529998] [140/164] (860s left) vgem_basic (setversion)
[151.721226] Starting subtest: setversion
[151.762912] Subtest setversion: SUCCESS (0.000s)
[151.850836] [141/164] (860s left) vgem_basic (create)
[152.050931] Starting subtest: create
[152.070241] Subtest create: SUCCESS (0.000s)
[152.153912] [142/164] (860s left) vgem_basic (debugfs)
[152.309742] Starting subtest: debugfs
[152.329311] Subtest debugfs: SUCCESS (0.001s)
[152.416720] [143/164] (860s left) vgem_basic (dmabuf-export)
[152.599031] Starting subtest: dmabuf-export
[152.642836] Subtest dmabuf-export: SUCCESS (0.003s)
[152.725988] [144/164] (859s left) vgem_basic (dmabuf-fence)
[152.907772] Starting subtest: dmabuf-fence
[152.928665] Subtest dmabuf-fence: SUCCESS (0.001s)
[153.007386] [145/164] (859s left) vgem_basic (dmabuf-fence-before)
[153.203702] Starting subtest: dmabuf-fence-before
[153.223352] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[153.329329] [146/164] (859s left) vgem_basic (dmabuf-mmap)
[153.506345] Starting subtest: dmabuf-mmap
[153.528170] Subtest dmabuf-mmap: SUCCESS (0.032s)
[153.612718] [147/164] (859s left) vgem_basic (mmap)
[153.804364] Starting subtest: mmap
[153.825740] Subtest mmap: SUCCESS (0.022s)
[153.912328] [148/164] (858s left) vgem_basic (second-client)
[154.103812] Starting subtest: second-client
[154.142675] Subtest second-client: SUCCESS (0.033s)
[154.229368] [149/164] (858s left) vgem_basic (sysfs)
[154.395557] Starting subtest: sysfs
[154.414754] Subtest sysfs: SUCCESS (0.001s)
[154.502652] [150/164] (858s left) core_hotunplug (unbind-rebind)
[154.729587] Starting subtest: unbind-rebind
[157.565312] Subtest unbind-rebind: SUCCESS (2.842s)
[157.648827] [151/164] (855s left) vgem_basic (unload)
[157.834125] Starting subtest: unload
[186.958079] Subtest unload: SUCCESS (28.933s)
[187.038339] [152/164] (826s left) i915_module_load (reload)
[187.223905] Starting subtest: reload
[189.244627] Subtest reload: SUCCESS (2.020s)
[189.377330] [153/164] (824s left) gem_lmem_swapping (basic)
[189.620084] Subtest basic: SKIP (0.000s)
[189.722981] [154/164] (823s left) gem_lmem_swapping (parallel-random-engines)
[189.966051] Subtest parallel-random-engines: SKIP (0.000s)
[190.067568] [155/164] (823s left) gem_lmem_swapping (random-engines)
[190.265800] Subtest random-engines: SKIP (0.000s)
[190.369055] [156/164] (823s left) gem_lmem_swapping (verify-random)
[190.611707] Subtest verify-random: SKIP (0.000s)
[190.705213] [157/164] (823s left) i915_pm_rpm (module-reload)
[192.301911] Subtest module-reload: SKIP (0.000s)
[192.386364] [158/164] (821s left) i915_selftest (live)
[193.211982] Starting subtest: live
[193.231267] Starting dynamic subtest: sanitycheck
[193.982672] Dynamic subtest sanitycheck: SUCCESS (0.767s)
[194.008721] Starting dynamic subtest: uncore
[194.677408] Dynamic subtest uncore: SUCCESS (0.689s)
[194.710338] Starting dynamic subtest: workarounds
[195.359835] Dynamic subtest workarounds: SUCCESS (0.684s)
[195.390081] Starting dynamic subtest: gt_engines
[196.136252] Dynamic subtest gt_engines: SUCCESS (0.770s)
[196.164084] Starting dynamic subtest: gt_timelines
[200.921201] Dynamic subtest gt_timelines: SUCCESS (4.784s)
[200.951361] Starting dynamic subtest: gt_contexts
[201.694291] Dynamic subtest gt_contexts: SUCCESS (0.766s)
[201.720203] Starting dynamic subtest: gt_lrc
[202.367045] Dynamic subtest gt_lrc: SUCCESS (0.674s)
[202.399354] Starting dynamic subtest: gt_mocs
[203.033381] Dynamic subtest gt_mocs: SUCCESS (0.662s)
[203.059823] Starting dynamic subtest: gt_pm
[204.183570] Dynamic subtest gt_pm: SUCCESS (1.149s)
[204.212429] Starting dynamic subtest: gt_heartbeat
[204.956601] Dynamic subtest gt_heartbeat: SUCCESS (0.771s)
[204.983096] Starting dynamic subtest: gt_tlb
[205.618675] Dynamic subtest gt_tlb: SUCCESS (0.654s)
[205.647151] Starting dynamic subtest: requests
[209.912887] Dynamic subtest requests: SUCCESS (4.293s)
[209.941521] Starting dynamic subtest: migrate
[210.598315] Dynamic subtest migrate: SUCCESS (0.682s)
[210.624509] Starting dynamic subtest: active
[211.329274] Dynamic subtest active: SUCCESS (0.727s)
[211.357385] Starting dynamic subtest: objects
[213.426509] Dynamic subtest objects: SUCCESS (2.097s)
[213.459232] Starting dynamic subtest: mman
[219.560061] Dynamic subtest mman: SUCCESS (6.129s)
[219.586302] Starting dynamic subtest: dmabuf
[220.256223] Dynamic subtest dmabuf: SUCCESS (0.690s)
[220.284130] Starting dynamic subtest: vma
[220.993900] Dynamic subtest vma: SUCCESS (0.737s)
[221.019545] Starting dynamic subtest: coherency
[222.705836] Dynamic subtest coherency: SUCCESS (1.707s)
[222.733822] Starting dynamic subtest: gtt
[226.792177] Dynamic subtest gtt: SUCCESS (4.081s)
[226.819897] Starting dynamic subtest: gem
[227.568085] Dynamic subtest gem: SUCCESS (0.774s)
[227.596187] Starting dynamic subtest: evict
[228.199231] Dynamic subtest evict: SUCCESS (0.631s)
[228.228681] Starting dynamic subtest: hugepages
[228.878416] Dynamic subtest hugepages: SUCCESS (0.674s)
[228.909174] Starting dynamic subtest: gem_contexts
[232.637454] Dynamic subtest gem_contexts: SUCCESS (3.755s)
[232.669966] Starting dynamic subtest: client
[233.290265] Dynamic subtest client: SUCCESS (0.653s)
[233.316478] Starting dynamic subtest: gem_migrate
[234.004147] Dynamic subtest gem_migrate: SUCCESS (0.706s)
[234.032684] Starting dynamic subtest: reset
[234.814253] Dynamic subtest reset: SUCCESS (0.809s)
[234.842603] Starting dynamic subtest: memory_region
[235.472688] Dynamic subtest memory_region: SUCCESS (0.658s)
[235.498682] Starting dynamic subtest: hangcheck
[237.731990] Dynamic subtest hangcheck: SUCCESS (2.255s)
[237.761201] Starting dynamic subtest: execlists
[238.458050] Dynamic subtest execlists: SUCCESS (0.718s)
[238.488626] Starting dynamic subtest: ring_submission
[239.115586] Dynamic subtest ring_submission: SUCCESS (0.651s)
[239.149703] Starting dynamic subtest: perf
[239.836454] Dynamic subtest perf: SUCCESS (0.718s)
[239.868685] Starting dynamic subtest: slpc
[240.509142] Dynamic subtest slpc: SUCCESS (0.674s)
[240.542116] Starting dynamic subtest: guc
[241.191491] Dynamic subtest guc: SUCCESS (0.675s)
[241.230092] Starting dynamic subtest: guc_multi_lrc
[241.952478] Dynamic subtest guc_multi_lrc: SUCCESS (0.763s)
[241.984492] Starting dynamic subtest: guc_hang
[242.616452] Dynamic subtest guc_hang: SUCCESS (0.663s)
[242.644394] Starting dynamic subtest: late_gt_pm
[243.261272] Dynamic subtest late_gt_pm: SUCCESS (0.644s)
[243.280953] Subtest live: SUCCESS (50.026s)
[243.386208] [159/164] (770s left) dmabuf (all-tests)
[243.540414] Starting subtest: all-tests
[243.562356] Starting dynamic subtest: sanitycheck
[243.623074] Dynamic subtest sanitycheck: SUCCESS (0.082s)
[243.650482] Starting dynamic subtest: dma_fence
[243.800831] Dynamic subtest dma_fence: SUCCESS (0.176s)
[243.829380] Starting dynamic subtest: dma_fence_chain
[260.288172] Dynamic subtest dma_fence_chain: SUCCESS (16.476s)
[260.320459] Starting dynamic subtest: dma_fence_unwrap
[260.378798] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[260.408495] Starting dynamic subtest: dma_resv
[260.456448] Dynamic subtest dma_resv: SUCCESS (0.073s)
[260.477714] Subtest all-tests: SUCCESS (16.909s)
[260.557774] [160/164] (753s left) i915_suspend (basic-s2idle-without-i915)
[260.747025] Starting subtest: basic-s2idle-without-i915
[278.511673] Subtest basic-s2idle-without-i915: SUCCESS (2.263s)
[283.723232] [161/164] (751s left) i915_suspend (basic-s3-without-i915)
[283.903287] Starting subtest: basic-s3-without-i915
[300.680318] Subtest basic-s3-without-i915: SUCCESS (1.915s)
[303.280635] [162/164] (748s left) gem_exec_suspend (basic-s0)
[303.498464] Starting subtest: basic-S0
[303.517063] Starting dynamic subtest: smem
[320.532639] Dynamic subtest smem: SUCCESS (1.992s)
[320.552166] Subtest basic-S0: SUCCESS (1.994s)
[323.349321] [163/164] (746s left) gem_exec_suspend (basic-s3)
[323.540301] Starting subtest: basic-S3
[323.559325] Starting dynamic subtest: smem
[340.583711] Dynamic subtest smem: SUCCESS (2.061s)
[340.604255] Subtest basic-S3: SUCCESS (2.063s)
[343.976552] [164/164] (744s left) kms_pipe_crc_basic (suspend-read-crc)
[344.173628] Starting subtest: suspend-read-crc
[344.194694] Starting dynamic subtest: pipe-A-VGA-1
[361.564893] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.701s)
[361.596167] Starting dynamic subtest: pipe-B-VGA-1
[378.564972] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.738s)
[378.586040] Subtest suspend-read-crc: SUCCESS (3.444s)
[381.704940] Closing watchdogs
Done.