[42.334552] Initializing watchdogs [42.334690] /dev/watchdog0 [42.366993] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:1916 Intel Skylake (Gen9) Skylake GT2 [HD Graphics 520] [42.374778] [001/162] (960s left) i915_module_load (load) [42.630269] Starting subtest: load [44.421744] Subtest load: SUCCESS (1.792s) [44.480663] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [44.484014] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [44.488362] [002/162] (958s left) core_auth (basic-auth) [44.571228] Starting subtest: basic-auth [44.572244] Subtest basic-auth: SUCCESS (0.001s) [44.733812] [003/162] (958s left) core_debugfs (read-all-entries) [44.815062] Starting subtest: read-all-entries [44.940740] Subtest read-all-entries: SUCCESS (0.131s) [45.080699] [004/162] (958s left) core_sysfs (read-all-entries) [45.151444] Starting subtest: read-all-entries [45.159132] Subtest read-all-entries: SUCCESS (0.008s) [45.271268] [005/162] (957s left) fbdev (eof) [45.357486] Starting subtest: eof [45.358561] Subtest eof: SUCCESS (0.001s) [45.517303] [006/162] (957s left) fbdev (info) [45.584052] Starting subtest: info [45.586144] Subtest info: SUCCESS (0.000s) [45.689494] [007/162] (957s left) fbdev (nullptr) [45.772541] Starting subtest: nullptr [45.773642] Subtest nullptr: SUCCESS (0.000s) [45.875216] [008/162] (957s left) fbdev (read) [45.956263] Starting subtest: read [46.843466] Subtest read: SUCCESS (0.887s) [46.939060] [009/162] (956s left) fbdev (write) [47.023035] Starting subtest: write [47.500151] Subtest write: SUCCESS (0.469s) [47.584392] [010/162] (955s left) gem_basic (bad-close) [47.653383] Starting subtest: bad-close [47.655450] Subtest bad-close: SUCCESS (0.000s) [47.755262] [011/162] (955s left) gem_basic (create-close) [47.821546] Starting subtest: create-close [47.823416] Subtest create-close: SUCCESS (0.000s) [47.986472] [012/162] (955s left) gem_basic (create-fd-close) [48.055535] Starting subtest: create-fd-close [48.057479] Subtest create-fd-close: SUCCESS (0.000s) [48.273633] [013/162] (955s left) gem_busy (busy@all-engines) [48.369407] Starting subtest: busy [48.370462] Starting dynamic subtest: all-engines [48.441505] Dynamic subtest all-engines: SUCCESS (0.072s) [48.442458] Subtest busy: SUCCESS (0.072s) [48.936257] [014/162] (954s left) gem_close_race (basic-process) [49.029551] Starting subtest: basic-process [49.099593] Subtest basic-process: SUCCESS (0.070s) [49.364134] [015/162] (954s left) gem_close_race (basic-threads) [49.456037] Starting subtest: basic-threads [50.721182] Subtest basic-threads: SUCCESS (1.266s) [51.028648] [016/162] (952s left) gem_ctx_create (basic) [51.118374] Starting subtest: basic [51.119481] Subtest basic: SUCCESS (0.000s) [51.381456] [017/162] (952s left) gem_ctx_create (basic-files) [51.468329] Starting subtest: basic-files [53.500288] Subtest basic-files: SUCCESS (2.042s) [53.765612] [018/162] (950s left) gem_ctx_exec (basic) [53.846233] Starting subtest: basic [53.853511] Subtest basic: SUCCESS (0.007s) [54.088034] [019/162] (950s left) gem_exec_basic (basic) [54.168127] Starting subtest: basic [54.169151] Starting dynamic subtest: rcs0-smem [54.171192] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [54.184507] Starting dynamic subtest: bcs0-smem [54.185474] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [54.198360] Starting dynamic subtest: vcs0-smem [54.199670] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [54.212476] Starting dynamic subtest: vecs0-smem [54.213787] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [54.215132] Subtest basic: SUCCESS (0.011s) [54.507637] [020/162] (949s left) gem_exec_create (basic) [54.592073] Starting subtest: basic [54.593030] Starting dynamic subtest: smem [56.647257] Dynamic subtest smem: SUCCESS (2.067s) [56.648685] Subtest basic: SUCCESS (2.068s) [56.933697] [021/162] (947s left) gem_exec_fence (basic-busy) [57.167185] Starting subtest: basic-busy [57.180259] Starting dynamic subtest: rcs0 [57.215306] Dynamic subtest rcs0: SUCCESS (0.070s) [57.232501] Starting dynamic subtest: bcs0 [57.240194] Dynamic subtest bcs0: SUCCESS (0.026s) [57.269720] Starting dynamic subtest: vcs0 [57.272236] Dynamic subtest vcs0: SUCCESS (0.030s) [57.285225] Starting dynamic subtest: vecs0 [57.295247] Dynamic subtest vecs0: SUCCESS (0.025s) [57.296538] Subtest basic-busy: SUCCESS (0.154s) [58.206201] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [58.210253] [022/162] (946s left) gem_exec_fence (basic-wait) [58.435716] Starting subtest: basic-wait [58.437488] Starting dynamic subtest: rcs0 [58.470505] Dynamic subtest rcs0: SUCCESS (0.036s) [58.493243] Starting dynamic subtest: bcs0 [58.501318] Dynamic subtest bcs0: SUCCESS (0.030s) [58.516393] Starting dynamic subtest: vcs0 [58.524227] Dynamic subtest vcs0: SUCCESS (0.023s) [58.537940] Starting dynamic subtest: vecs0 [58.546328] Dynamic subtest vecs0: SUCCESS (0.022s) [58.547576] Subtest basic-wait: SUCCESS (0.113s) [59.312976] [023/162] (945s left) gem_exec_fence (basic-await) [59.558337] Starting subtest: basic-await [59.559727] Starting dynamic subtest: rcs0 [59.662361] Dynamic subtest rcs0: SUCCESS (0.104s) [59.678109] Starting dynamic subtest: bcs0 [59.767763] Dynamic subtest bcs0: SUCCESS (0.105s) [59.787817] Starting dynamic subtest: vcs0 [59.882950] Dynamic subtest vcs0: SUCCESS (0.114s) [59.902595] Starting dynamic subtest: vecs0 [60.005579] Dynamic subtest vecs0: SUCCESS (0.123s) [60.006636] Subtest basic-await: SUCCESS (0.449s) [60.792864] [024/162] (943s left) gem_exec_fence (nb-await) [61.043360] Starting subtest: nb-await [61.045043] Starting dynamic subtest: rcs0 [61.115728] Dynamic subtest rcs0: SUCCESS (0.071s) [61.142911] Starting dynamic subtest: bcs0 [61.191728] Dynamic subtest bcs0: SUCCESS (0.074s) [61.231553] Starting dynamic subtest: vcs0 [61.277749] Dynamic subtest vcs0: SUCCESS (0.087s) [61.295784] Starting dynamic subtest: vecs0 [61.341409] Dynamic subtest vecs0: SUCCESS (0.063s) [61.343335] Subtest nb-await: SUCCESS (0.300s) [62.118581] [025/162] (942s left) gem_exec_gttfill (basic) [62.206308] Starting subtest: basic [68.553824] Subtest basic: SUCCESS (6.349s) [68.850597] [026/162] (936s left) gem_exec_parallel (engines) [69.048029] Starting subtest: engines [69.049086] Starting dynamic subtest: basic [71.747213] Dynamic subtest basic: SUCCESS (2.682s) [71.761677] Starting dynamic subtest: contexts [77.461594] Dynamic subtest contexts: SUCCESS (5.738s) [77.479501] Starting dynamic subtest: fds [87.771854] Dynamic subtest fds: SUCCESS (10.310s) [87.787242] Starting dynamic subtest: userptr [90.430220] Dynamic subtest userptr: SUCCESS (2.657s) [90.431094] Subtest engines: SUCCESS (21.389s) [90.729035] [027/162] (914s left) gem_exec_store (basic) [90.816316] Starting subtest: basic [90.874345] Subtest basic: SUCCESS (0.059s) [91.164494] [028/162] (913s left) gem_flink_basic (bad-flink) [91.234287] Starting subtest: bad-flink [91.235391] Subtest bad-flink: SUCCESS (0.000s) [91.348180] [029/162] (913s left) gem_flink_basic (bad-open) [91.415927] Starting subtest: bad-open [91.417077] Subtest bad-open: SUCCESS (0.000s) [91.533023] [030/162] (913s left) gem_flink_basic (basic) [91.605210] Starting subtest: basic [91.606186] Subtest basic: SUCCESS (0.000s) [91.805385] [031/162] (913s left) gem_flink_basic (double-flink) [91.880548] Starting subtest: double-flink [91.881562] Subtest double-flink: SUCCESS (0.000s) [92.029336] [032/162] (913s left) gem_flink_basic (flink-lifetime) [92.098506] Starting subtest: flink-lifetime [92.100406] Subtest flink-lifetime: SUCCESS (0.002s) [92.309683] [033/162] (913s left) gem_huc_copy (huc-copy) [92.393016] Starting subtest: huc-copy [92.395179] Subtest huc-copy: SKIP (0.000s) [92.572914] [034/162] (912s left) gem_linear_blits (basic) [92.788047] Starting subtest: basic [92.800490] Subtest basic: SUCCESS (0.013s) [93.048886] [035/162] (912s left) gem_mmap (basic) [93.191194] Starting subtest: basic [93.196257] Subtest basic: SUCCESS (0.001s) [93.380331] [036/162] (912s left) gem_mmap_gtt (basic) [93.449985] Starting subtest: basic [93.451145] Subtest basic: SUCCESS (0.001s) [93.627242] [037/162] (912s left) gem_render_linear_blits (basic) [93.708516] Starting subtest: basic [93.757969] Subtest basic: SUCCESS (0.049s) [93.867656] [038/162] (912s left) gem_render_tiled_blits (basic) [93.949898] Starting subtest: basic [94.003206] Subtest basic: SUCCESS (0.053s) [94.100113] [039/162] (911s left) gem_ringfill (basic-all) [94.394333] Starting subtest: basic-all [95.557354] Subtest basic-all: SUCCESS (1.154s) [95.707060] [040/162] (910s left) gem_softpin (allocator-basic) [95.789149] Starting subtest: allocator-basic [95.981567] Subtest allocator-basic: SUCCESS (0.185s) [96.151863] [041/162] (909s left) gem_softpin (allocator-basic-reserve) [96.228938] Starting subtest: allocator-basic-reserve [96.411401] Subtest allocator-basic-reserve: SUCCESS (0.173s) [96.557113] [042/162] (909s left) gem_softpin (safe-alignment) [96.634973] Starting subtest: safe-alignment [96.653820] Subtest safe-alignment: SUCCESS (0.019s) [96.849967] [043/162] (909s left) gem_sync (basic-all) [96.943193] Starting subtest: basic-all [98.998444] Subtest basic-all: SUCCESS (2.056s) [99.322910] [044/162] (907s left) gem_sync (basic-each) [99.412540] Starting subtest: basic-each [101.590756] Subtest basic-each: SUCCESS (2.178s) [101.946271] [045/162] (904s left) gem_tiled_blits (basic) [102.186131] Starting subtest: basic [102.219171] Subtest basic: SUCCESS (0.032s) [102.404919] [046/162] (904s left) gem_tiled_fence_blits (basic) [102.652000] Starting subtest: basic [102.666344] Subtest basic: SUCCESS (0.015s) [102.906576] [047/162] (903s left) gem_tiled_pread_basic (basic) [103.038238] Starting subtest: basic [103.207224] Subtest basic: SUCCESS (0.163s) [103.409961] [048/162] (903s left) gem_wait (busy@all-engines) [103.507717] Starting subtest: busy [103.509132] Starting dynamic subtest: all-engines [104.038453] Dynamic subtest all-engines: SUCCESS (0.531s) [104.039474] Subtest busy: SUCCESS (0.531s) [104.334234] [049/162] (902s left) gem_wait (wait@all-engines) [104.427992] Starting subtest: wait [104.429268] Starting dynamic subtest: all-engines [105.488767] Dynamic subtest all-engines: SUCCESS (1.055s) [105.491791] Subtest wait: SUCCESS (1.057s) [105.836399] [050/162] (901s left) i915_getparams_basic (basic-eu-total) [105.905342] Starting subtest: basic-eu-total [105.907474] Subtest basic-eu-total: SUCCESS (0.000s) [106.022768] [051/162] (901s left) i915_getparams_basic (basic-subslice-total) [106.092425] Starting subtest: basic-subslice-total [106.094424] Subtest basic-subslice-total: SUCCESS (0.000s) [106.224855] [052/162] (900s left) i915_hangman (error-state-basic) [106.315267] Starting subtest: error-state-basic [106.325229] Subtest error-state-basic: SUCCESS (0.010s) [106.469862] [053/162] (900s left) i915_pciid [106.671233] [054/162] (900s left) intel_hwmon (hwmon-read) [106.742294] Subtest hwmon-read: SKIP (0.000s) [106.826570] [055/162] (900s left) intel_hwmon (hwmon-write) [106.897860] Subtest hwmon-write: SKIP (0.000s) [106.993627] [056/162] (900s left) kms_addfb_basic (addfb25-4-tiled) [107.133852] Starting subtest: addfb25-4-tiled [107.134902] Subtest addfb25-4-tiled: SUCCESS (0.001s) [107.282948] [057/162] (900s left) kms_addfb_basic (addfb25-bad-modifier) [107.406248] Starting subtest: addfb25-bad-modifier [107.407288] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [107.593360] [058/162] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [107.715290] Starting subtest: addfb25-framebuffer-vs-set-tiling [107.716205] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.879774] [059/162] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [108.002976] Starting subtest: addfb25-modifier-no-flag [108.004092] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [108.168887] [060/162] (899s left) kms_addfb_basic (addfb25-x-tiled-legacy) [108.292176] Starting subtest: addfb25-x-tiled-legacy [108.293078] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [108.485316] [061/162] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [108.607318] Starting subtest: addfb25-x-tiled-mismatch-legacy [108.608416] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [108.747147] [062/162] (899s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.869249] Starting subtest: addfb25-yf-tiled-legacy [108.870266] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [109.054228] [063/162] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [109.175495] Starting subtest: addfb25-y-tiled-legacy [109.176490] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [109.387137] [064/162] (898s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [109.512133] Starting subtest: addfb25-y-tiled-small-legacy [109.513183] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [109.665310] [065/162] (898s left) kms_addfb_basic (bad-pitch-0) [109.735181] Starting subtest: bad-pitch-0 [109.736122] Subtest bad-pitch-0: SUCCESS (0.000s) [109.973733] [066/162] (898s left) kms_addfb_basic (bad-pitch-1024) [110.052111] Starting subtest: bad-pitch-1024 [110.053149] Subtest bad-pitch-1024: SUCCESS (0.000s) [110.289740] [067/162] (898s left) kms_addfb_basic (bad-pitch-128) [110.359694] Starting subtest: bad-pitch-128 [110.360739] Subtest bad-pitch-128: SUCCESS (0.000s) [110.621281] [068/162] (897s left) kms_addfb_basic (bad-pitch-256) [110.693232] Starting subtest: bad-pitch-256 [110.694229] Subtest bad-pitch-256: SUCCESS (0.000s) [110.896480] [069/162] (897s left) kms_addfb_basic (bad-pitch-32) [110.966462] Starting subtest: bad-pitch-32 [110.967475] Subtest bad-pitch-32: SUCCESS (0.000s) [111.179826] [070/162] (897s left) kms_addfb_basic (bad-pitch-63) [111.249027] Starting subtest: bad-pitch-63 [111.250126] Subtest bad-pitch-63: SUCCESS (0.000s) [111.481554] [071/162] (897s left) kms_addfb_basic (bad-pitch-65536) [111.552899] Starting subtest: bad-pitch-65536 [111.553920] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.780403] [072/162] (897s left) kms_addfb_basic (bad-pitch-999) [111.857418] Starting subtest: bad-pitch-999 [111.858408] Subtest bad-pitch-999: SUCCESS (0.000s) [112.101489] [073/162] (896s left) kms_addfb_basic (basic) [112.172342] Starting subtest: basic [112.173360] Subtest basic: SUCCESS (0.000s) [112.371705] [074/162] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [112.442365] Starting subtest: basic-x-tiled-legacy [112.443385] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.668294] [075/162] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [112.740430] Starting subtest: basic-y-tiled-legacy [112.741350] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [112.982725] [076/162] (896s left) kms_addfb_basic (bo-too-small) [113.105218] Starting subtest: bo-too-small [113.106221] Subtest bo-too-small: SUCCESS (0.000s) [113.271885] [077/162] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.395219] Starting subtest: bo-too-small-due-to-tiling [113.396281] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [113.579587] [078/162] (895s left) kms_addfb_basic (clobberred-modifier) [113.650291] Starting subtest: clobberred-modifier [113.651180] Subtest clobberred-modifier: SUCCESS (0.000s) [113.905436] [079/162] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.975331] Starting subtest: framebuffer-vs-set-tiling [113.976284] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.183042] [080/162] (895s left) kms_addfb_basic (invalid-get-prop) [114.253466] Starting subtest: invalid-get-prop [114.254404] Subtest invalid-get-prop: SUCCESS (0.000s) [114.481354] [081/162] (895s left) kms_addfb_basic (invalid-get-prop-any) [114.551161] Starting subtest: invalid-get-prop-any [114.552208] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.766050] [082/162] (894s left) kms_addfb_basic (invalid-set-prop) [114.836420] Starting subtest: invalid-set-prop [114.837395] Subtest invalid-set-prop: SUCCESS (0.000s) [115.074790] [083/162] (894s left) kms_addfb_basic (invalid-set-prop-any) [115.144590] Starting subtest: invalid-set-prop-any [115.145678] Subtest invalid-set-prop-any: SUCCESS (0.000s) [115.345705] [084/162] (894s left) kms_addfb_basic (no-handle) [115.415642] Starting subtest: no-handle [115.416697] Subtest no-handle: SUCCESS (0.000s) [115.628405] [085/162] (894s left) kms_addfb_basic (size-max) [115.757199] Starting subtest: size-max [115.758129] Subtest size-max: SUCCESS (0.000s) [115.918429] [086/162] (894s left) kms_addfb_basic (small-bo) [116.038540] Starting subtest: small-bo [116.039584] Subtest small-bo: SUCCESS (0.000s) [116.206564] [087/162] (893s left) kms_addfb_basic (tile-pitch-mismatch) [116.277589] Starting subtest: tile-pitch-mismatch [116.278565] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [116.510637] [088/162] (893s left) kms_addfb_basic (too-high) [116.636230] Starting subtest: too-high [116.637240] Subtest too-high: SUCCESS (0.001s) [116.800941] [089/162] (893s left) kms_addfb_basic (too-wide) [116.924340] Starting subtest: too-wide [116.925509] Subtest too-wide: SUCCESS (0.000s) [117.162788] [090/162] (893s left) kms_addfb_basic (unused-handle) [117.256036] Starting subtest: unused-handle [117.257080] Subtest unused-handle: SUCCESS (0.000s) [117.542803] [091/162] (893s left) kms_addfb_basic (unused-modifier) [117.611961] Starting subtest: unused-modifier [117.614024] Subtest unused-modifier: SUCCESS (0.000s) [117.801468] [092/162] (892s left) kms_addfb_basic (unused-offsets) [117.871556] Starting subtest: unused-offsets [117.872559] Subtest unused-offsets: SUCCESS (0.000s) [118.141978] [093/162] (892s left) kms_addfb_basic (unused-pitches) [118.212041] Starting subtest: unused-pitches [118.213100] Subtest unused-pitches: SUCCESS (0.000s) [118.434324] [094/162] (892s left) kms_busy (basic) [118.562192] Starting subtest: basic [118.563113] Starting dynamic subtest: flip [119.515150] Dynamic subtest flip: SUCCESS (0.949s) [119.535568] Starting dynamic subtest: modeset [123.239845] Dynamic subtest modeset: SUCCESS (3.724s) [123.243317] Subtest basic: SUCCESS (4.678s) [124.190449] [095/162] (886s left) kms_prop_blob (basic) [124.261220] Starting subtest: basic [124.262223] Subtest basic: SUCCESS (0.000s) [124.405898] [096/162] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.528049] Starting subtest: basic-busy-flip-before-cursor-atomic [124.529928] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [124.682348] [097/162] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [124.806104] Starting subtest: basic-busy-flip-before-cursor-legacy [124.807943] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [124.960020] [098/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [125.088018] Starting subtest: basic-flip-after-cursor-atomic [126.390143] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.298s) [127.247547] [099/162] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [127.371950] Starting subtest: basic-flip-after-cursor-legacy [128.668558] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.291s) [129.584770] [100/162] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [129.706158] Starting subtest: basic-flip-after-cursor-varying-size [131.006636] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.295s) [131.894903] [101/162] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [132.017991] Starting subtest: basic-flip-before-cursor-atomic [133.280444] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.260s) [134.191721] [102/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [134.313183] Starting subtest: basic-flip-before-cursor-legacy [135.625159] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.308s) [136.503017] [103/162] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [136.629442] Starting subtest: basic-flip-before-cursor-varying-size [137.863477] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.232s) [138.830608] [104/162] (872s left) kms_dsc (dsc-basic) [138.953777] Subtest dsc-basic: SKIP (0.000s) [139.045353] [105/162] (872s left) kms_flip (basic-flip-vs-dpms) [139.170168] Starting subtest: basic-flip-vs-dpms [139.173172] Starting dynamic subtest: A-eDP1 [142.020947] Dynamic subtest A-eDP1: SUCCESS (2.846s) [142.093326] Starting dynamic subtest: B-eDP1 [144.307481] Dynamic subtest B-eDP1: SUCCESS (2.276s) [144.373068] Starting dynamic subtest: C-eDP1 [146.595255] Dynamic subtest C-eDP1: SUCCESS (2.280s) [146.604266] Subtest basic-flip-vs-dpms: SUCCESS (7.433s) [147.461199] [106/162] (864s left) kms_flip (basic-flip-vs-modeset) [147.586220] Starting subtest: basic-flip-vs-modeset [147.590748] Starting dynamic subtest: A-eDP1 [150.213464] Dynamic subtest A-eDP1: SUCCESS (2.621s) [150.280809] Starting dynamic subtest: B-eDP1 [152.577441] Dynamic subtest B-eDP1: SUCCESS (2.352s) [152.649231] Starting dynamic subtest: C-eDP1 [154.989223] Dynamic subtest C-eDP1: SUCCESS (2.410s) [155.004397] Subtest basic-flip-vs-modeset: SUCCESS (7.419s) [155.938279] [107/162] (856s left) kms_flip (basic-flip-vs-wf_vblank) [156.066962] Starting subtest: basic-flip-vs-wf_vblank [156.071564] Starting dynamic subtest: A-eDP1 [158.307640] Dynamic subtest A-eDP1: SUCCESS (2.236s) [158.328767] Starting dynamic subtest: B-eDP1 [160.523177] Dynamic subtest B-eDP1: SUCCESS (2.214s) [160.545066] Starting dynamic subtest: C-eDP1 [162.706912] Dynamic subtest C-eDP1: SUCCESS (2.182s) [162.711176] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.646s) [163.954248] [108/162] (848s left) kms_flip (basic-plain-flip) [164.083133] Starting subtest: basic-plain-flip [164.087617] Starting dynamic subtest: A-eDP1 [165.943785] Dynamic subtest A-eDP1: SUCCESS (1.851s) [166.005626] Starting dynamic subtest: B-eDP1 [167.869953] Dynamic subtest B-eDP1: SUCCESS (1.922s) [167.892808] Starting dynamic subtest: C-eDP1 [169.796382] Dynamic subtest C-eDP1: SUCCESS (1.921s) [169.808801] Subtest basic-plain-flip: SUCCESS (5.726s) [171.288422] [109/162] (840s left) kms_force_connector_basic (force-connector-state) [171.388308] Starting subtest: force-connector-state [171.967126] Subtest force-connector-state: SUCCESS (0.579s) [173.277976] [110/162] (839s left) kms_force_connector_basic (force-edid) [173.376523] Starting subtest: force-edid [173.409757] Subtest force-edid: SUCCESS (0.034s) [173.628525] [111/162] (838s left) kms_force_connector_basic (force-load-detect) [173.726181] Starting subtest: force-load-detect [173.728343] Subtest force-load-detect: SKIP (0.000s) [173.928213] [112/162] (838s left) kms_force_connector_basic (prune-stale-modes) [174.027160] Starting subtest: prune-stale-modes [174.061926] Subtest prune-stale-modes: SUCCESS (0.035s) [174.285178] [113/162] (838s left) kms_frontbuffer_tracking (basic) [174.425476] Starting subtest: basic [178.075445] Subtest basic: SUCCESS (3.652s) [178.264366] [114/162] (834s left) kms_hdmi_inject (inject-audio) [178.649339] Starting subtest: inject-audio [178.782579] Subtest inject-audio: SUCCESS (0.133s) [179.745497] [115/162] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [179.869096] Starting subtest: compare-crc-sanitycheck-xr24 [179.870195] Starting dynamic subtest: pipe-A-eDP-1 [180.614353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s) [180.689587] Starting dynamic subtest: pipe-B-eDP-1 [182.056892] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s) [182.142443] Starting dynamic subtest: pipe-C-eDP-1 [183.417207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s) [183.419723] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.549s) [184.396218] [116/162] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [184.524129] Starting subtest: compare-crc-sanitycheck-nv12 [184.525114] Starting dynamic subtest: pipe-A-eDP-1 [184.527047] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [184.549920] Starting dynamic subtest: pipe-B-eDP-1 [184.552034] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [184.571450] Starting dynamic subtest: pipe-C-eDP-1 [184.573573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [184.575761] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s) [184.660452] [117/162] (828s left) kms_pipe_crc_basic (hang-read-crc)