[39.760067] Initializing watchdogs
[39.760195]   /dev/watchdog0
[39.790850] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:1916 Intel Skylake (Gen9) Skylake GT2 [HD Graphics 520]
[39.800413] [001/162] (960s left) i915_module_load (load)
[39.878118] Starting subtest: load
[41.668288] Subtest load: SUCCESS (1.790s)
[41.733500] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[41.736843] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[41.741253] [002/162] (958s left) core_auth (basic-auth)
[41.829230] Starting subtest: basic-auth
[41.830153] Subtest basic-auth: SUCCESS (0.001s)
[41.965407] [003/162] (958s left) core_debugfs (read-all-entries)
[42.031278] Starting subtest: read-all-entries
[42.167124] Subtest read-all-entries: SUCCESS (0.136s)
[42.329411] [004/162] (958s left) core_sysfs (read-all-entries)
[42.401346] Starting subtest: read-all-entries
[42.414372] Subtest read-all-entries: SUCCESS (0.006s)
[42.558253] [005/162] (958s left) fbdev (eof)
[42.661556] Starting subtest: eof
[42.664411] Subtest eof: SUCCESS (0.001s)
[42.847746] [006/162] (957s left) fbdev (info)
[42.931237] Starting subtest: info
[42.932164] Subtest info: SUCCESS (0.000s)
[43.117291] [007/162] (957s left) fbdev (nullptr)
[43.192985] Starting subtest: nullptr
[43.194055] Subtest nullptr: SUCCESS (0.000s)
[43.288486] [008/162] (957s left) fbdev (read)
[43.359743] Starting subtest: read
[44.263308] Subtest read: SUCCESS (0.895s)
[44.376477] [009/162] (956s left) fbdev (write)
[44.461201] Starting subtest: write
[44.932915] Subtest write: SUCCESS (0.464s)
[45.048318] [010/162] (955s left) gem_basic (bad-close)
[45.124556] Starting subtest: bad-close
[45.126488] Subtest bad-close: SUCCESS (0.000s)
[45.308170] [011/162] (955s left) gem_basic (create-close)
[45.384063] Starting subtest: create-close
[45.385928] Subtest create-close: SUCCESS (0.000s)
[45.576338] [012/162] (955s left) gem_basic (create-fd-close)
[45.643911] Starting subtest: create-fd-close
[45.646010] Subtest create-fd-close: SUCCESS (0.000s)
[45.827541] [013/162] (955s left) gem_busy (busy@all-engines)
[45.920072] Starting subtest: busy
[45.921151] Starting dynamic subtest: all-engines
[45.976792] Dynamic subtest all-engines: SUCCESS (0.057s)
[45.977829] Subtest busy: SUCCESS (0.057s)
[46.486130] [014/162] (954s left) gem_close_race (basic-process)
[46.576486] Starting subtest: basic-process
[46.653089] Subtest basic-process: SUCCESS (0.077s)
[46.957377] [015/162] (954s left) gem_close_race (basic-threads)
[47.052134] Starting subtest: basic-threads
[48.260188] Subtest basic-threads: SUCCESS (1.208s)
[48.576817] [016/162] (952s left) gem_ctx_create (basic)
[48.664498] Starting subtest: basic
[48.665489] Subtest basic: SUCCESS (0.000s)
[48.966844] [017/162] (952s left) gem_ctx_create (basic-files)
[49.056785] Starting subtest: basic-files
[51.077137] Subtest basic-files: SUCCESS (2.021s)
[51.416180] [018/162] (950s left) gem_ctx_exec (basic)
[51.488747] Starting subtest: basic
[51.496898] Subtest basic: SUCCESS (0.008s)
[51.698470] [019/162] (949s left) gem_exec_basic (basic)
[51.776213] Starting subtest: basic
[51.777288] Starting dynamic subtest: rcs0-smem
[51.779506] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[51.795517] Starting dynamic subtest: bcs0-smem
[51.796791] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[51.809558] Starting dynamic subtest: vcs0-smem
[51.810822] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[51.822827] Starting dynamic subtest: vecs0-smem
[51.824163] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[51.825484] Subtest basic: SUCCESS (0.009s)
[52.117272] [020/162] (949s left) gem_exec_create (basic)
[52.197334] Starting subtest: basic
[52.198335] Starting dynamic subtest: smem
[54.240418] Dynamic subtest smem: SUCCESS (2.134s)
[54.241493] Subtest basic: SUCCESS (2.135s)
[54.541351] [021/162] (947s left) gem_exec_fence (basic-busy)
[54.773751] Starting subtest: basic-busy
[54.774776] Starting dynamic subtest: rcs0
[54.811218] Dynamic subtest rcs0: SUCCESS (0.039s)
[54.823409] Starting dynamic subtest: bcs0
[54.842242] Dynamic subtest bcs0: SUCCESS (0.032s)
[54.854416] Starting dynamic subtest: vcs0
[54.870158] Dynamic subtest vcs0: SUCCESS (0.029s)
[54.883080] Starting dynamic subtest: vecs0
[54.892168] Dynamic subtest vecs0: SUCCESS (0.022s)
[54.893117] Subtest basic-busy: SUCCESS (0.123s)
[55.706271] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[55.709938] [022/162] (946s left) gem_exec_fence (basic-wait)
[55.951596] Starting subtest: basic-wait
[55.952863] Starting dynamic subtest: rcs0
[55.980170] Dynamic subtest rcs0: SUCCESS (0.029s)
[55.992439] Starting dynamic subtest: bcs0
[56.009142] Dynamic subtest bcs0: SUCCESS (0.029s)
[56.021349] Starting dynamic subtest: vcs0
[56.033181] Dynamic subtest vcs0: SUCCESS (0.024s)
[56.045495] Starting dynamic subtest: vecs0
[56.056159] Dynamic subtest vecs0: SUCCESS (0.023s)
[56.057340] Subtest basic-wait: SUCCESS (0.108s)
[56.785960] [023/162] (945s left) gem_exec_fence (basic-await)
[57.032974] Starting subtest: basic-await
[57.041293] Starting dynamic subtest: rcs0
[57.133531] Dynamic subtest rcs0: SUCCESS (0.103s)
[57.150252] Starting dynamic subtest: bcs0
[57.235891] Dynamic subtest bcs0: SUCCESS (0.104s)
[57.255148] Starting dynamic subtest: vcs0
[57.339808] Dynamic subtest vcs0: SUCCESS (0.106s)
[57.352756] Starting dynamic subtest: vecs0
[57.439176] Dynamic subtest vecs0: SUCCESS (0.101s)
[57.440551] Subtest basic-await: SUCCESS (0.416s)
[58.343877] [024/162] (943s left) gem_exec_fence (nb-await)
[58.589032] Starting subtest: nb-await
[58.590466] Starting dynamic subtest: rcs0
[58.659638] Dynamic subtest rcs0: SUCCESS (0.073s)
[58.691271] Starting dynamic subtest: bcs0
[58.742540] Dynamic subtest bcs0: SUCCESS (0.082s)
[58.790178] Starting dynamic subtest: vcs0
[58.840589] Dynamic subtest vcs0: SUCCESS (0.097s)
[58.895635] Starting dynamic subtest: vecs0
[58.946921] Dynamic subtest vecs0: SUCCESS (0.102s)
[58.949768] Subtest nb-await: SUCCESS (0.365s)
[59.793812] [025/162] (942s left) gem_exec_gttfill (basic)
[59.880714] Starting subtest: basic
[64.723188] Subtest basic: SUCCESS (4.905s)
[65.054698] [026/162] (937s left) gem_exec_parallel (engines)
[65.209476] Starting subtest: engines
[65.210444] Starting dynamic subtest: basic
[68.848998] Dynamic subtest basic: SUCCESS (3.664s)
[68.865934] Starting dynamic subtest: contexts
[73.817994] Dynamic subtest contexts: SUCCESS (4.988s)
[73.833490] Starting dynamic subtest: fds
[82.543538] Dynamic subtest fds: SUCCESS (8.739s)
[82.560187] Starting dynamic subtest: userptr
[86.024252] Dynamic subtest userptr: SUCCESS (3.455s)
[86.025625] Subtest engines: SUCCESS (20.848s)
[86.335201] [027/162] (915s left) gem_exec_store (basic)
[86.420242] Starting subtest: basic
[86.495612] Subtest basic: SUCCESS (0.075s)
[86.833797] [028/162] (915s left) gem_flink_basic (bad-flink)
[86.902980] Starting subtest: bad-flink
[86.904061] Subtest bad-flink: SUCCESS (0.000s)
[87.048777] [029/162] (915s left) gem_flink_basic (bad-open)
[87.117154] Starting subtest: bad-open
[87.118188] Subtest bad-open: SUCCESS (0.000s)
[87.313876] [030/162] (915s left) gem_flink_basic (basic)
[87.382856] Starting subtest: basic
[87.383977] Subtest basic: SUCCESS (0.000s)
[87.627869] [031/162] (915s left) gem_flink_basic (double-flink)
[87.712209] Starting subtest: double-flink
[87.713204] Subtest double-flink: SUCCESS (0.000s)
[87.904257] [032/162] (914s left) gem_flink_basic (flink-lifetime)
[87.973456] Starting subtest: flink-lifetime
[87.975597] Subtest flink-lifetime: SUCCESS (0.002s)
[88.145520] [033/162] (914s left) gem_huc_copy (huc-copy)
[88.224350] Starting subtest: huc-copy
[88.226305] Subtest huc-copy: SKIP (0.000s)
[88.438968] [034/162] (914s left) gem_linear_blits (basic)
[88.664861] Starting subtest: basic
[88.680550] Subtest basic: SUCCESS (0.016s)
[88.905387] [035/162] (914s left) gem_mmap (basic)
[89.041759] Starting subtest: basic
[89.046284] Subtest basic: SUCCESS (0.001s)
[89.237182] [036/162] (913s left) gem_mmap_gtt (basic)
[89.306361] Starting subtest: basic
[89.307339] Subtest basic: SUCCESS (0.002s)
[89.467229] [037/162] (913s left) gem_render_linear_blits (basic)
[89.545214] Starting subtest: basic
[89.591860] Subtest basic: SUCCESS (0.046s)
[89.691947] [038/162] (913s left) gem_render_tiled_blits (basic)
[89.769962] Starting subtest: basic
[89.822080] Subtest basic: SUCCESS (0.052s)
[89.925631] [039/162] (913s left) gem_ringfill (basic-all)
[90.209394] Starting subtest: basic-all
[91.375135] Subtest basic-all: SUCCESS (1.156s)
[91.587431] [040/162] (911s left) gem_softpin (allocator-basic)
[91.664334] Starting subtest: allocator-basic
[91.853357] Subtest allocator-basic: SUCCESS (0.180s)
[92.068482] [041/162] (911s left) gem_softpin (allocator-basic-reserve)
[92.143467] Starting subtest: allocator-basic-reserve
[92.318480] Subtest allocator-basic-reserve: SUCCESS (0.166s)
[92.538776] [042/162] (911s left) gem_softpin (safe-alignment)
[92.616921] Starting subtest: safe-alignment
[92.636545] Subtest safe-alignment: SUCCESS (0.019s)
[92.840315] [043/162] (910s left) gem_sync (basic-all)
[92.929158] Starting subtest: basic-all
[95.018863] Subtest basic-all: SUCCESS (2.089s)
[95.343275] [044/162] (908s left) gem_sync (basic-each)
[95.436503] Starting subtest: basic-each
[97.679353] Subtest basic-each: SUCCESS (2.242s)
[98.051273] [045/162] (905s left) gem_tiled_blits (basic)
[98.218255] Starting subtest: basic
[98.240439] Subtest basic: SUCCESS (0.022s)
[98.464304] [046/162] (905s left) gem_tiled_fence_blits (basic)
[98.703769] Starting subtest: basic
[98.718053] Subtest basic: SUCCESS (0.014s)
[98.933239] [047/162] (905s left) gem_tiled_pread_basic (basic)
[99.059858] Starting subtest: basic
[99.240169] Subtest basic: SUCCESS (0.173s)
[99.434268] [048/162] (904s left) gem_wait (busy@all-engines)
[99.540606] Starting subtest: busy
[99.541746] Starting dynamic subtest: all-engines
[100.074267] Dynamic subtest all-engines: SUCCESS (0.533s)
[100.075306] Subtest busy: SUCCESS (0.534s)
[100.396991] [049/162] (903s left) gem_wait (wait@all-engines)
[100.488546] Starting subtest: wait
[100.489566] Starting dynamic subtest: all-engines
[101.564617] Dynamic subtest all-engines: SUCCESS (1.074s)
[101.567759] Subtest wait: SUCCESS (1.076s)
[101.911988] [050/162] (902s left) i915_getparams_basic (basic-eu-total)
[101.979373] Starting subtest: basic-eu-total
[101.981150] Subtest basic-eu-total: SUCCESS (0.000s)
[102.152707] [051/162] (902s left) i915_getparams_basic (basic-subslice-total)
[102.219383] Starting subtest: basic-subslice-total
[102.221229] Subtest basic-subslice-total: SUCCESS (0.000s)
[102.366650] [052/162] (902s left) i915_hangman (error-state-basic)
[102.461226] Starting subtest: error-state-basic
[102.473897] Subtest error-state-basic: SUCCESS (0.012s)
[102.685327] [053/162] (901s left) i915_pciid
[102.919319] [054/162] (901s left) intel_hwmon (hwmon-read)
[102.989248] Subtest hwmon-read: SKIP (0.000s)
[103.079223] [055/162] (901s left) intel_hwmon (hwmon-write)
[103.151972] Subtest hwmon-write: SKIP (0.000s)
[103.231325] [056/162] (901s left) kms_addfb_basic (addfb25-4-tiled)
[103.363621] Starting subtest: addfb25-4-tiled
[103.364577] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[103.582274] [057/162] (901s left) kms_addfb_basic (addfb25-bad-modifier)
[103.710444] Starting subtest: addfb25-bad-modifier
[103.711388] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[103.879018] [058/162] (901s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[104.001265] Starting subtest: addfb25-framebuffer-vs-set-tiling
[104.002221] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[104.209611] [059/162] (900s left) kms_addfb_basic (addfb25-modifier-no-flag)
[104.335288] Starting subtest: addfb25-modifier-no-flag
[104.336236] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[104.527933] [060/162] (900s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[104.651347] Starting subtest: addfb25-x-tiled-legacy
[104.652339] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[104.832067] [061/162] (900s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.954173] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.955152] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[105.159989] [062/162] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.288190] Starting subtest: addfb25-yf-tiled-legacy
[105.289122] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[105.458085] [063/162] (899s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[105.584245] Starting subtest: addfb25-y-tiled-legacy
[105.585142] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[105.810972] [064/162] (899s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.939428] Starting subtest: addfb25-y-tiled-small-legacy
[105.940409] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[106.147692] [065/162] (899s left) kms_addfb_basic (bad-pitch-0)
[106.215214] Starting subtest: bad-pitch-0
[106.216131] Subtest bad-pitch-0: SUCCESS (0.000s)
[106.433735] [066/162] (899s left) kms_addfb_basic (bad-pitch-1024)
[106.501472] Starting subtest: bad-pitch-1024
[106.502377] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.756086] [067/162] (898s left) kms_addfb_basic (bad-pitch-128)
[106.824455] Starting subtest: bad-pitch-128
[106.825425] Subtest bad-pitch-128: SUCCESS (0.000s)
[107.058395] [068/162] (898s left) kms_addfb_basic (bad-pitch-256)
[107.127102] Starting subtest: bad-pitch-256
[107.128880] Subtest bad-pitch-256: SUCCESS (0.000s)
[107.337680] [069/162] (898s left) kms_addfb_basic (bad-pitch-32)
[107.406120] Starting subtest: bad-pitch-32
[107.407078] Subtest bad-pitch-32: SUCCESS (0.000s)
[107.657225] [070/162] (898s left) kms_addfb_basic (bad-pitch-63)
[107.726229] Starting subtest: bad-pitch-63
[107.727183] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.981664] [071/162] (898s left) kms_addfb_basic (bad-pitch-65536)
[108.050499] Starting subtest: bad-pitch-65536
[108.051491] Subtest bad-pitch-65536: SUCCESS (0.000s)
[108.298797] [072/162] (897s left) kms_addfb_basic (bad-pitch-999)
[108.367197] Starting subtest: bad-pitch-999
[108.368117] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.611526] [073/162] (897s left) kms_addfb_basic (basic)
[108.687237] Starting subtest: basic
[108.688133] Subtest basic: SUCCESS (0.000s)
[108.918114] [074/162] (897s left) kms_addfb_basic (basic-x-tiled-legacy)
[108.988408] Starting subtest: basic-x-tiled-legacy
[108.989439] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[109.229390] [075/162] (897s left) kms_addfb_basic (basic-y-tiled-legacy)
[109.299177] Starting subtest: basic-y-tiled-legacy
[109.300143] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[109.532635] [076/162] (896s left) kms_addfb_basic (bo-too-small)
[109.670222] Starting subtest: bo-too-small
[109.671202] Subtest bo-too-small: SUCCESS (0.000s)
[109.839729] [077/162] (896s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[109.962129] Starting subtest: bo-too-small-due-to-tiling
[109.963319] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[110.168239] [078/162] (896s left) kms_addfb_basic (clobberred-modifier)
[110.236996] Starting subtest: clobberred-modifier
[110.238095] Subtest clobberred-modifier: SUCCESS (0.000s)
[110.480833] [079/162] (896s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.551234] Starting subtest: framebuffer-vs-set-tiling
[110.552207] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[110.788567] [080/162] (896s left) kms_addfb_basic (invalid-get-prop)
[110.859841] Starting subtest: invalid-get-prop
[110.860897] Subtest invalid-get-prop: SUCCESS (0.000s)
[111.088319] [081/162] (895s left) kms_addfb_basic (invalid-get-prop-any)
[111.156390] Starting subtest: invalid-get-prop-any
[111.157329] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[111.421615] [082/162] (895s left) kms_addfb_basic (invalid-set-prop)
[111.490421] Starting subtest: invalid-set-prop
[111.491380] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.735606] [083/162] (895s left) kms_addfb_basic (invalid-set-prop-any)
[111.805287] Starting subtest: invalid-set-prop-any
[111.806273] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[112.020604] [084/162] (895s left) kms_addfb_basic (no-handle)
[112.089200] Starting subtest: no-handle
[112.090199] Subtest no-handle: SUCCESS (0.000s)
[112.354788] [085/162] (894s left) kms_addfb_basic (size-max)
[112.476980] Starting subtest: size-max
[112.478097] Subtest size-max: SUCCESS (0.000s)
[112.673515] [086/162] (894s left) kms_addfb_basic (small-bo)
[112.797297] Starting subtest: small-bo
[112.798216] Subtest small-bo: SUCCESS (0.000s)
[112.993169] [087/162] (894s left) kms_addfb_basic (tile-pitch-mismatch)
[113.063046] Starting subtest: tile-pitch-mismatch
[113.064123] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[113.278408] [088/162] (894s left) kms_addfb_basic (too-high)
[113.399223] Starting subtest: too-high
[113.400267] Subtest too-high: SUCCESS (0.001s)
[113.600568] [089/162] (893s left) kms_addfb_basic (too-wide)
[113.722305] Starting subtest: too-wide
[113.723279] Subtest too-wide: SUCCESS (0.000s)
[113.917556] [090/162] (893s left) kms_addfb_basic (unused-handle)
[113.984992] Starting subtest: unused-handle
[113.986122] Subtest unused-handle: SUCCESS (0.000s)
[114.181060] [091/162] (893s left) kms_addfb_basic (unused-modifier)
[114.249415] Starting subtest: unused-modifier
[114.250437] Subtest unused-modifier: SUCCESS (0.000s)
[114.512525] [092/162] (893s left) kms_addfb_basic (unused-offsets)
[114.580266] Starting subtest: unused-offsets
[114.581238] Subtest unused-offsets: SUCCESS (0.000s)
[114.849745] [093/162] (893s left) kms_addfb_basic (unused-pitches)
[114.916795] Starting subtest: unused-pitches
[114.918037] Subtest unused-pitches: SUCCESS (0.000s)
[115.164474] [094/162] (892s left) kms_busy (basic)
[115.291220] Starting subtest: basic
[115.292462] Starting dynamic subtest: flip
[116.203452] Dynamic subtest flip: SUCCESS (0.909s)
[116.225668] Starting dynamic subtest: modeset
[119.828956] Dynamic subtest modeset: SUCCESS (3.624s)
[119.831882] Subtest basic: SUCCESS (4.537s)
[120.798478] [095/162] (887s left) kms_prop_blob (basic)
[120.868845] Starting subtest: basic
[120.869926] Subtest basic: SUCCESS (0.000s)
[121.017471] [096/162] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[121.137197] Starting subtest: basic-busy-flip-before-cursor-atomic
[121.139059] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[121.309997] [097/162] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[121.434354] Starting subtest: basic-busy-flip-before-cursor-legacy
[121.436171] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[121.595195] [098/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[121.722164] Starting subtest: basic-flip-after-cursor-atomic
[123.000212] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.274s)
[123.946990] [099/162] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[124.068318] Starting subtest: basic-flip-after-cursor-legacy
[125.363676] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.292s)
[126.368821] [100/162] (882s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[126.502322] Starting subtest: basic-flip-after-cursor-varying-size
[127.854876] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.350s)
[128.789592] [101/162] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[128.913650] Starting subtest: basic-flip-before-cursor-atomic
[130.214978] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.299s)
[131.175538] [102/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[131.308366] Starting subtest: basic-flip-before-cursor-legacy
[132.613173] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.299s)
[133.611277] [103/162] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[133.737837] Starting subtest: basic-flip-before-cursor-varying-size
[135.087852] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.345s)
[135.997187] [104/162] (872s left) kms_dsc (dsc-basic)
[136.117845] Subtest dsc-basic: SKIP (0.000s)
[136.209355] [105/162] (872s left) kms_flip (basic-flip-vs-dpms)
[136.331469] Starting subtest: basic-flip-vs-dpms
[136.333880] Starting dynamic subtest: A-eDP1
[139.103189] Dynamic subtest A-eDP1: SUCCESS (2.767s)
[139.168092] Starting dynamic subtest: B-eDP1
[141.378624] Dynamic subtest B-eDP1: SUCCESS (2.267s)
[141.439555] Starting dynamic subtest: C-eDP1
[143.692524] Dynamic subtest C-eDP1: SUCCESS (2.306s)
[143.701591] Subtest basic-flip-vs-dpms: SUCCESS (7.369s)
[144.688958] [106/162] (864s left) kms_flip (basic-flip-vs-modeset)
[144.813160] Starting subtest: basic-flip-vs-modeset
[144.815534] Starting dynamic subtest: A-eDP1
[147.599785] Dynamic subtest A-eDP1: SUCCESS (2.775s)
[147.633083] Starting dynamic subtest: B-eDP1
[149.995591] Dynamic subtest B-eDP1: SUCCESS (2.393s)
[150.069381] Starting dynamic subtest: C-eDP1
[152.358881] Dynamic subtest C-eDP1: SUCCESS (2.361s)
[152.370578] Subtest basic-flip-vs-modeset: SUCCESS (7.558s)
[153.331775] [107/162] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[153.460338] Starting subtest: basic-flip-vs-wf_vblank
[153.464568] Starting dynamic subtest: A-eDP1
[155.627939] Dynamic subtest A-eDP1: SUCCESS (2.163s)
[155.651218] Starting dynamic subtest: B-eDP1
[157.865304] Dynamic subtest B-eDP1: SUCCESS (2.235s)
[157.887639] Starting dynamic subtest: C-eDP1
[160.034149] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[160.037590] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.579s)
[161.318568] [108/162] (848s left) kms_flip (basic-plain-flip)
[161.443917] Starting subtest: basic-plain-flip
[161.448015] Starting dynamic subtest: A-eDP1
[163.366920] Dynamic subtest A-eDP1: SUCCESS (1.912s)
[163.425658] Starting dynamic subtest: B-eDP1
[165.382510] Dynamic subtest B-eDP1: SUCCESS (2.014s)
[165.399984] Starting dynamic subtest: C-eDP1
[167.308510] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[167.321225] Subtest basic-plain-flip: SUCCESS (5.877s)
[168.714882] [109/162] (840s left) kms_force_connector_basic (force-connector-state)
[168.817143] Starting subtest: force-connector-state
[169.449143] Subtest force-connector-state: SUCCESS (0.627s)
[170.661022] [110/162] (838s left) kms_force_connector_basic (force-edid)
[170.762876] Starting subtest: force-edid
[170.801783] Subtest force-edid: SUCCESS (0.039s)
[171.058301] [111/162] (838s left) kms_force_connector_basic (force-load-detect)
[171.155018] Starting subtest: force-load-detect
[171.156861] Subtest force-load-detect: SKIP (0.000s)
[171.361260] [112/162] (838s left) kms_force_connector_basic (prune-stale-modes)
[171.465071] Starting subtest: prune-stale-modes
[171.502426] Subtest prune-stale-modes: SUCCESS (0.037s)
[171.749521] [113/162] (838s left) kms_frontbuffer_tracking (basic)
[171.879156] Starting subtest: basic
[175.488876] Subtest basic: SUCCESS (3.610s)
[175.724548] [114/162] (834s left) kms_hdmi_inject (inject-audio)
[176.118368] Starting subtest: inject-audio
[176.252796] Subtest inject-audio: SUCCESS (0.136s)
[177.073301] [115/162] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[177.199966] Starting subtest: compare-crc-sanitycheck-xr24
[177.201218] Starting dynamic subtest: pipe-A-eDP-1
[178.015713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[178.097110] Starting dynamic subtest: pipe-B-eDP-1
[179.510063] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s)
[179.592269] Starting dynamic subtest: pipe-C-eDP-1
[181.010222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[181.012867] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.809s)
[181.998757] [116/162] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[182.123963] Starting subtest: compare-crc-sanitycheck-nv12
[182.125116] Starting dynamic subtest: pipe-A-eDP-1
[182.127065] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[182.144327] Starting dynamic subtest: pipe-B-eDP-1
[182.146652] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[182.162655] Starting dynamic subtest: pipe-C-eDP-1
[182.164892] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[182.167041] Subtest compare-crc-sanitycheck-nv12: SKIP (0.012s)
[182.323210] [117/162] (827s left) kms_pipe_crc_basic (hang-read-crc)
[182.445205] Starting subtest: hang-read-crc
[182.448196] Starting dynamic subtest: pipe-A-eDP-1
[185.070609] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.622s)
[185.157482] Starting dynamic subtest: pipe-B-eDP-1
[188.341693] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.254s)
[188.406941] Starting dynamic subtest: pipe-C-eDP-1
[191.653613] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.303s)
[191.656518] Subtest hang-read-crc: SUCCESS (9.210s)
[192.677057] [118/162] (817s left) kms_pipe_crc_basic (nonblocking-crc)
[192.856477] Starting subtest: nonblocking-crc
[192.859461] Starting dynamic subtest: pipe-A-eDP-1
[193.961622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.100s)
[194.044079] Starting dynamic subtest: pipe-B-eDP-1
[195.736365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.752s)
[195.814620] Starting dynamic subtest: pipe-C-eDP-1
[197.512172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.763s)
[197.514520] Subtest nonblocking-crc: SUCCESS (4.654s)
[198.483751] [119/162] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[198.612471] Starting subtest: nonblocking-crc-frame-sequence
[198.613437] Starting dynamic subtest: pipe-A-eDP-1
[199.633388] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.019s)
[199.709903] Starting dynamic subtest: pipe-B-eDP-1
[201.448548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.789s)
[201.524861] Starting dynamic subtest: pipe-C-eDP-1
[203.179261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.716s)
[203.181645] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.568s)
[204.128076] [120/162] (806s left) kms_pipe_crc_basic (read-crc)