[40.789049] Initializing watchdogs [40.789180] /dev/watchdog0 [40.819989] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:1916 Intel Skylake (Gen9) Skylake GT2 [HD Graphics 520] [40.827905] [001/162] (960s left) i915_module_load (load) [40.904796] Starting subtest: load [42.605089] Subtest load: SUCCESS (1.699s) [42.675775] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [42.679279] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [42.683709] [002/162] (958s left) core_auth (basic-auth) [42.765268] Starting subtest: basic-auth [42.766291] Subtest basic-auth: SUCCESS (0.001s) [42.910242] [003/162] (958s left) core_debugfs (read-all-entries) [42.976376] Starting subtest: read-all-entries [43.086138] Subtest read-all-entries: SUCCESS (0.111s) [43.233640] [004/162] (958s left) core_sysfs (read-all-entries) [43.303640] Starting subtest: read-all-entries [43.309696] Subtest read-all-entries: SUCCESS (0.006s) [43.494959] [005/162] (958s left) fbdev (eof) [43.581053] Starting subtest: eof [43.582237] Subtest eof: SUCCESS (0.001s) [43.764311] [006/162] (957s left) fbdev (info) [43.831979] Starting subtest: info [43.835395] Subtest info: SUCCESS (0.000s) [43.959975] [007/162] (957s left) fbdev (nullptr) [44.030306] Starting subtest: nullptr [44.031272] Subtest nullptr: SUCCESS (0.000s) [44.162234] [008/162] (957s left) fbdev (read) [44.230169] Starting subtest: read [45.116809] Subtest read: SUCCESS (0.887s) [45.263694] [009/162] (956s left) fbdev (write) [45.351424] Starting subtest: write [45.829080] Subtest write: SUCCESS (0.469s) [45.929923] [010/162] (956s left) gem_basic (bad-close) [46.003220] Starting subtest: bad-close [46.005302] Subtest bad-close: SUCCESS (0.000s) [46.117663] [011/162] (956s left) gem_basic (create-close) [46.190388] Starting subtest: create-close [46.192295] Subtest create-close: SUCCESS (0.000s) [46.368977] [012/162] (955s left) gem_basic (create-fd-close) [46.436059] Starting subtest: create-fd-close [46.438360] Subtest create-fd-close: SUCCESS (0.000s) [46.625787] [013/162] (955s left) gem_busy (busy@all-engines) [46.721230] Starting subtest: busy [46.722278] Starting dynamic subtest: all-engines [46.786057] Dynamic subtest all-engines: SUCCESS (0.065s) [46.787162] Subtest busy: SUCCESS (0.066s) [47.290415] [014/162] (955s left) gem_close_race (basic-process) [47.387590] Starting subtest: basic-process [47.474395] Subtest basic-process: SUCCESS (0.086s) [47.749252] [015/162] (954s left) gem_close_race (basic-threads) [47.844244] Starting subtest: basic-threads [49.091198] Subtest basic-threads: SUCCESS (1.247s) [49.421826] [016/162] (953s left) gem_ctx_create (basic) [49.505692] Starting subtest: basic [49.506700] Subtest basic: SUCCESS (0.000s) [49.820937] [017/162] (952s left) gem_ctx_create (basic-files) [49.903289] Starting subtest: basic-files [51.924162] Subtest basic-files: SUCCESS (2.021s) [52.296074] [018/162] (950s left) gem_ctx_exec (basic) [52.371178] Starting subtest: basic [52.375975] Subtest basic: SUCCESS (0.006s) [52.576536] [019/162] (950s left) gem_exec_basic (basic) [52.655157] Starting subtest: basic [52.656140] Starting dynamic subtest: rcs0-smem [52.659235] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [52.672075] Starting dynamic subtest: bcs0-smem [52.673014] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [52.685505] Starting dynamic subtest: vcs0-smem [52.686753] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [52.699144] Starting dynamic subtest: vecs0-smem [52.700323] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [52.701533] Subtest basic: SUCCESS (0.011s) [52.995713] [020/162] (949s left) gem_exec_create (basic) [53.087383] Starting subtest: basic [53.088372] Starting dynamic subtest: smem [55.140580] Dynamic subtest smem: SUCCESS (1.974s) [55.141763] Subtest basic: SUCCESS (1.974s) [55.459951] [021/162] (947s left) gem_exec_fence (basic-busy) [55.720764] Starting subtest: basic-busy [55.722095] Starting dynamic subtest: rcs0 [55.753359] Dynamic subtest rcs0: SUCCESS (0.031s) [55.766592] Starting dynamic subtest: bcs0 [55.782302] Dynamic subtest bcs0: SUCCESS (0.028s) [55.797444] Starting dynamic subtest: vcs0 [55.803342] Dynamic subtest vcs0: SUCCESS (0.020s) [55.818826] Starting dynamic subtest: vecs0 [55.826289] Dynamic subtest vecs0: SUCCESS (0.022s) [55.827373] Subtest basic-busy: SUCCESS (0.103s) [56.679401] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [56.683078] [022/162] (946s left) gem_exec_fence (basic-wait) [56.919985] Starting subtest: basic-wait [56.921304] Starting dynamic subtest: rcs0 [56.942361] Dynamic subtest rcs0: SUCCESS (0.022s) [56.956927] Starting dynamic subtest: bcs0 [56.968333] Dynamic subtest bcs0: SUCCESS (0.025s) [56.981919] Starting dynamic subtest: vcs0 [56.995269] Dynamic subtest vcs0: SUCCESS (0.026s) [57.008607] Starting dynamic subtest: vecs0 [57.021231] Dynamic subtest vecs0: SUCCESS (0.025s) [57.022483] Subtest basic-wait: SUCCESS (0.099s) [57.810254] [023/162] (945s left) gem_exec_fence (basic-await) [58.054510] Starting subtest: basic-await [58.055539] Starting dynamic subtest: rcs0 [58.159174] Dynamic subtest rcs0: SUCCESS (0.102s) [58.172963] Starting dynamic subtest: bcs0 [58.261746] Dynamic subtest bcs0: SUCCESS (0.100s) [58.281334] Starting dynamic subtest: vcs0 [58.369657] Dynamic subtest vcs0: SUCCESS (0.105s) [58.383287] Starting dynamic subtest: vecs0 [58.470841] Dynamic subtest vecs0: SUCCESS (0.098s) [58.472078] Subtest basic-await: SUCCESS (0.408s) [59.293630] [024/162] (943s left) gem_exec_fence (nb-await) [59.534983] Starting subtest: nb-await [59.536297] Starting dynamic subtest: rcs0 [59.607630] Dynamic subtest rcs0: SUCCESS (0.071s) [59.634922] Starting dynamic subtest: bcs0 [59.688124] Dynamic subtest bcs0: SUCCESS (0.077s) [59.745356] Starting dynamic subtest: vcs0 [59.790394] Dynamic subtest vcs0: SUCCESS (0.096s) [59.836229] Starting dynamic subtest: vecs0 [59.882717] Dynamic subtest vecs0: SUCCESS (0.090s) [59.885260] Subtest nb-await: SUCCESS (0.342s) [60.709844] [025/162] (942s left) gem_exec_gttfill (basic) [60.796039] Starting subtest: basic [66.103548] Subtest basic: SUCCESS (5.245s) [66.421001] [026/162] (936s left) gem_exec_parallel (engines) [66.580587] Starting subtest: engines [66.581549] Starting dynamic subtest: basic [69.660716] Dynamic subtest basic: SUCCESS (3.040s) [69.678880] Starting dynamic subtest: contexts [77.002043] Dynamic subtest contexts: SUCCESS (7.338s) [77.016704] Starting dynamic subtest: fds [85.320470] Dynamic subtest fds: SUCCESS (8.308s) [85.335524] Starting dynamic subtest: userptr [89.022944] Dynamic subtest userptr: SUCCESS (3.698s) [89.024441] Subtest engines: SUCCESS (22.386s) [89.346407] [027/162] (913s left) gem_exec_store (basic) [89.435258] Starting subtest: basic [89.523915] Subtest basic: SUCCESS (0.088s) [89.824391] [028/162] (913s left) gem_flink_basic (bad-flink) [89.898147] Starting subtest: bad-flink [89.899189] Subtest bad-flink: SUCCESS (0.000s) [90.059658] [029/162] (913s left) gem_flink_basic (bad-open) [90.135218] Starting subtest: bad-open [90.136278] Subtest bad-open: SUCCESS (0.000s) [90.302219] [030/162] (913s left) gem_flink_basic (basic) [90.374480] Starting subtest: basic [90.375507] Subtest basic: SUCCESS (0.000s) [90.579399] [031/162] (913s left) gem_flink_basic (double-flink) [90.708677] Starting subtest: double-flink [90.709637] Subtest double-flink: SUCCESS (0.000s) [90.957043] [032/162] (912s left) gem_flink_basic (flink-lifetime) [91.023534] Starting subtest: flink-lifetime [91.025703] Subtest flink-lifetime: SUCCESS (0.002s) [91.227065] [033/162] (912s left) gem_huc_copy (huc-copy) [91.305286] Starting subtest: huc-copy [91.307538] Subtest huc-copy: SKIP (0.000s) [91.504895] [034/162] (912s left) gem_linear_blits (basic) [91.733201] Starting subtest: basic [91.748190] Subtest basic: SUCCESS (0.015s) [91.990824] [035/162] (912s left) gem_mmap (basic) [92.124489] Starting subtest: basic [92.129179] Subtest basic: SUCCESS (0.000s) [92.314327] [036/162] (911s left) gem_mmap_gtt (basic) [92.383580] Starting subtest: basic [92.384588] Subtest basic: SUCCESS (0.001s) [92.553408] [037/162] (911s left) gem_render_linear_blits (basic) [92.634093] Starting subtest: basic [92.679125] Subtest basic: SUCCESS (0.045s) [92.774041] [038/162] (911s left) gem_render_tiled_blits (basic) [92.851324] Starting subtest: basic [92.903766] Subtest basic: SUCCESS (0.052s) [93.010385] [039/162] (911s left) gem_ringfill (basic-all) [93.288404] Starting subtest: basic-all [94.463516] Subtest basic-all: SUCCESS (1.165s) [94.668891] [040/162] (909s left) gem_softpin (allocator-basic) [94.743949] Starting subtest: allocator-basic [94.929038] Subtest allocator-basic: SUCCESS (0.176s) [95.126099] [041/162] (909s left) gem_softpin (allocator-basic-reserve) [95.204014] Starting subtest: allocator-basic-reserve [95.377719] Subtest allocator-basic-reserve: SUCCESS (0.165s) [95.584879] [042/162] (909s left) gem_softpin (safe-alignment) [95.666672] Starting subtest: safe-alignment [95.687806] Subtest safe-alignment: SUCCESS (0.020s) [95.909702] [043/162] (908s left) gem_sync (basic-all) [96.004076] Starting subtest: basic-all [98.163512] Subtest basic-all: SUCCESS (2.159s) [98.481260] [044/162] (906s left) gem_sync (basic-each) [98.571967] Starting subtest: basic-each [100.860715] Subtest basic-each: SUCCESS (2.290s) [101.251593] [045/162] (903s left) gem_tiled_blits (basic) [101.408437] Starting subtest: basic [101.429000] Subtest basic: SUCCESS (0.020s) [101.653361] [046/162] (903s left) gem_tiled_fence_blits (basic) [101.892484] Starting subtest: basic [101.906599] Subtest basic: SUCCESS (0.014s) [102.132963] [047/162] (902s left) gem_tiled_pread_basic (basic) [102.258404] Starting subtest: basic [102.434453] Subtest basic: SUCCESS (0.167s) [102.623990] [048/162] (902s left) gem_wait (busy@all-engines) [102.721097] Starting subtest: busy [102.722179] Starting dynamic subtest: all-engines [103.258163] Dynamic subtest all-engines: SUCCESS (0.537s) [103.259225] Subtest busy: SUCCESS (0.537s) [103.578348] [049/162] (901s left) gem_wait (wait@all-engines) [103.668451] Starting subtest: wait [103.669586] Starting dynamic subtest: all-engines [104.725750] Dynamic subtest all-engines: SUCCESS (1.054s) [104.729521] Subtest wait: SUCCESS (1.056s) [105.106489] [050/162] (900s left) i915_getparams_basic (basic-eu-total) [105.173996] Starting subtest: basic-eu-total [105.176141] Subtest basic-eu-total: SUCCESS (0.000s) [105.332803] [051/162] (900s left) i915_getparams_basic (basic-subslice-total) [105.404085] Starting subtest: basic-subslice-total [105.406022] Subtest basic-subslice-total: SUCCESS (0.000s) [105.645877] [052/162] (899s left) i915_hangman (error-state-basic) [105.746167] Starting subtest: error-state-basic [105.756303] Subtest error-state-basic: SUCCESS (0.010s) [105.900797] [053/162] (899s left) i915_pciid [106.104683] [054/162] (899s left) intel_hwmon (hwmon-read) [106.172959] Subtest hwmon-read: SKIP (0.000s) [106.285450] [055/162] (899s left) intel_hwmon (hwmon-write) [106.355894] Subtest hwmon-write: SKIP (0.000s) [106.445339] [056/162] (899s left) kms_addfb_basic (addfb25-4-tiled) [106.577153] Starting subtest: addfb25-4-tiled [106.578225] Subtest addfb25-4-tiled: SUCCESS (0.000s) [106.797306] [057/162] (899s left) kms_addfb_basic (addfb25-bad-modifier) [106.921336] Starting subtest: addfb25-bad-modifier [106.922332] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [107.122209] [058/162] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [107.242955] Starting subtest: addfb25-framebuffer-vs-set-tiling [107.244101] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [107.387853] [059/162] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [107.511197] Starting subtest: addfb25-modifier-no-flag [107.512116] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [107.721151] [060/162] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [107.842220] Starting subtest: addfb25-x-tiled-legacy [107.843150] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [108.026306] [061/162] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [108.145221] Starting subtest: addfb25-x-tiled-mismatch-legacy [108.146298] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [108.329526] [062/162] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.452266] Starting subtest: addfb25-yf-tiled-legacy [108.453221] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [108.635189] [063/162] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.759220] Starting subtest: addfb25-y-tiled-legacy [108.760225] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [108.910291] [064/162] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [109.035182] Starting subtest: addfb25-y-tiled-small-legacy [109.036169] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [109.232623] [065/162] (897s left) kms_addfb_basic (bad-pitch-0) [109.302271] Starting subtest: bad-pitch-0 [109.303289] Subtest bad-pitch-0: SUCCESS (0.000s) [109.555111] [066/162] (897s left) kms_addfb_basic (bad-pitch-1024) [109.624033] Starting subtest: bad-pitch-1024 [109.625028] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.866700] [067/162] (896s left) kms_addfb_basic (bad-pitch-128) [109.935128] Starting subtest: bad-pitch-128 [109.936105] Subtest bad-pitch-128: SUCCESS (0.000s) [110.185228] [068/162] (896s left) kms_addfb_basic (bad-pitch-256) [110.253327] Starting subtest: bad-pitch-256 [110.254245] Subtest bad-pitch-256: SUCCESS (0.000s) [110.506896] [069/162] (896s left) kms_addfb_basic (bad-pitch-32) [110.576232] Starting subtest: bad-pitch-32 [110.577250] Subtest bad-pitch-32: SUCCESS (0.000s) [110.803298] [070/162] (896s left) kms_addfb_basic (bad-pitch-63) [110.870982] Starting subtest: bad-pitch-63 [110.872120] Subtest bad-pitch-63: SUCCESS (0.000s) [111.133309] [071/162] (896s left) kms_addfb_basic (bad-pitch-65536) [111.200625] Starting subtest: bad-pitch-65536 [111.201825] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.460252] [072/162] (895s left) kms_addfb_basic (bad-pitch-999) [111.528255] Starting subtest: bad-pitch-999 [111.529232] Subtest bad-pitch-999: SUCCESS (0.000s) [111.776582] [073/162] (895s left) kms_addfb_basic (basic) [111.844179] Starting subtest: basic [111.845151] Subtest basic: SUCCESS (0.000s) [112.074036] [074/162] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [112.142861] Starting subtest: basic-x-tiled-legacy [112.143841] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.397894] [075/162] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [112.467897] Starting subtest: basic-y-tiled-legacy [112.468917] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [112.704228] [076/162] (894s left) kms_addfb_basic (bo-too-small) [112.829191] Starting subtest: bo-too-small [112.830135] Subtest bo-too-small: SUCCESS (0.000s) [112.989908] [077/162] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.110224] Starting subtest: bo-too-small-due-to-tiling [113.111180] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [113.345768] [078/162] (894s left) kms_addfb_basic (clobberred-modifier) [113.413377] Starting subtest: clobberred-modifier [113.414378] Subtest clobberred-modifier: SUCCESS (0.000s) [113.665273] [079/162] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.734285] Starting subtest: framebuffer-vs-set-tiling [113.735295] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.989222] [080/162] (893s left) kms_addfb_basic (invalid-get-prop) [114.059339] Starting subtest: invalid-get-prop [114.060246] Subtest invalid-get-prop: SUCCESS (0.000s) [114.309050] [081/162] (893s left) kms_addfb_basic (invalid-get-prop-any) [114.376267] Starting subtest: invalid-get-prop-any [114.377263] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.601995] [082/162] (893s left) kms_addfb_basic (invalid-set-prop) [114.670459] Starting subtest: invalid-set-prop [114.671476] Subtest invalid-set-prop: SUCCESS (0.000s) [114.919766] [083/162] (893s left) kms_addfb_basic (invalid-set-prop-any) [114.988557] Starting subtest: invalid-set-prop-any [114.989562] Subtest invalid-set-prop-any: SUCCESS (0.000s) [115.245454] [084/162] (893s left) kms_addfb_basic (no-handle) [115.312872] Starting subtest: no-handle [115.313935] Subtest no-handle: SUCCESS (0.000s) [115.571596] [085/162] (892s left) kms_addfb_basic (size-max) [115.690283] Starting subtest: size-max [115.691301] Subtest size-max: SUCCESS (0.000s) [115.860904] [086/162] (892s left) kms_addfb_basic (small-bo) [115.979969] Starting subtest: small-bo [115.981019] Subtest small-bo: SUCCESS (0.000s) [116.192132] [087/162] (892s left) kms_addfb_basic (tile-pitch-mismatch) [116.261495] Starting subtest: tile-pitch-mismatch [116.262460] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [116.506590] [088/162] (892s left) kms_addfb_basic (too-high) [116.632191] Starting subtest: too-high [116.633114] Subtest too-high: SUCCESS (0.001s) [116.786873] [089/162] (891s left) kms_addfb_basic (too-wide) [116.907233] Starting subtest: too-wide [116.908206] Subtest too-wide: SUCCESS (0.000s) [117.110884] [090/162] (891s left) kms_addfb_basic (unused-handle) [117.179075] Starting subtest: unused-handle [117.179983] Subtest unused-handle: SUCCESS (0.000s) [117.430730] [091/162] (891s left) kms_addfb_basic (unused-modifier) [117.497819] Starting subtest: unused-modifier [117.498890] Subtest unused-modifier: SUCCESS (0.000s) [117.695329] [092/162] (891s left) kms_addfb_basic (unused-offsets) [117.764497] Starting subtest: unused-offsets [117.765519] Subtest unused-offsets: SUCCESS (0.000s) [118.035115] [093/162] (890s left) kms_addfb_basic (unused-pitches) [118.102084] Starting subtest: unused-pitches [118.103181] Subtest unused-pitches: SUCCESS (0.000s) [118.361508] [094/162] (890s left) kms_busy (basic) [118.493058] Starting subtest: basic [118.495219] Starting dynamic subtest: flip [119.348609] Dynamic subtest flip: SUCCESS (0.852s) [119.379254] Starting dynamic subtest: modeset [123.050679] Dynamic subtest modeset: SUCCESS (3.699s) [123.053252] Subtest basic: SUCCESS (4.557s) [123.973336] [095/162] (885s left) kms_prop_blob (basic) [124.049889] Starting subtest: basic [124.051059] Subtest basic: SUCCESS (0.000s) [124.229612] [096/162] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.354521] Starting subtest: basic-busy-flip-before-cursor-atomic [124.356481] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [124.523688] [097/162] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [124.652445] Starting subtest: basic-busy-flip-before-cursor-legacy [124.654461] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [124.802660] [098/162] (884s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [124.941408] Starting subtest: basic-flip-after-cursor-atomic [126.271603] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.325s) [127.208230] [099/162] (882s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [127.327265] Starting subtest: basic-flip-after-cursor-legacy [128.628657] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.294s) [129.621703] [100/162] (880s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [129.743187] Starting subtest: basic-flip-after-cursor-varying-size [131.073079] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.328s) [132.049783] [101/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [132.168182] Starting subtest: basic-flip-before-cursor-atomic [133.445502] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.275s) [134.411737] [102/162] (875s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [134.533169] Starting subtest: basic-flip-before-cursor-legacy [135.837729] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.304s) [136.869397] [103/162] (873s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [136.993150] Starting subtest: basic-flip-before-cursor-varying-size [138.331123] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.336s) [139.273939] [104/162] (870s left) kms_dsc (dsc-basic) [139.393878] Subtest dsc-basic: SKIP (0.000s) [139.479575] [105/162] (870s left) kms_flip (basic-flip-vs-dpms) [139.600199] Starting subtest: basic-flip-vs-dpms [139.602805] Starting dynamic subtest: A-eDP1 [142.395603] Dynamic subtest A-eDP1: SUCCESS (2.789s) [142.463059] Starting dynamic subtest: B-eDP1 [144.713165] Dynamic subtest B-eDP1: SUCCESS (2.309s) [144.787137] Starting dynamic subtest: C-eDP1 [147.009322] Dynamic subtest C-eDP1: SUCCESS (2.289s) [147.018104] Subtest basic-flip-vs-dpms: SUCCESS (7.416s) [148.032901] [106/162] (862s left) kms_flip (basic-flip-vs-modeset) [148.153172] Starting subtest: basic-flip-vs-modeset [148.155595] Starting dynamic subtest: A-eDP1 [150.931231] Dynamic subtest A-eDP1: SUCCESS (2.773s) [150.998104] Starting dynamic subtest: B-eDP1 [153.269290] Dynamic subtest B-eDP1: SUCCESS (2.334s) [153.340643] Starting dynamic subtest: C-eDP1 [155.635373] Dynamic subtest C-eDP1: SUCCESS (2.357s) [155.656204] Subtest basic-flip-vs-modeset: SUCCESS (7.499s) [156.588126] [107/162] (853s left) kms_flip (basic-flip-vs-wf_vblank) [156.709803] Starting subtest: basic-flip-vs-wf_vblank [156.712442] Starting dynamic subtest: A-eDP1 [158.855906] Dynamic subtest A-eDP1: SUCCESS (2.144s) [158.881225] Starting dynamic subtest: B-eDP1 [160.973084] Dynamic subtest B-eDP1: SUCCESS (2.115s) [160.996145] Starting dynamic subtest: C-eDP1 [163.182952] Dynamic subtest C-eDP1: SUCCESS (2.208s) [163.187116] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.479s) [164.495880] [108/162] (845s left) kms_flip (basic-plain-flip) [164.617047] Starting subtest: basic-plain-flip [164.619579] Starting dynamic subtest: A-eDP1 [166.499731] Dynamic subtest A-eDP1: SUCCESS (1.880s) [166.524041] Starting dynamic subtest: B-eDP1 [168.434918] Dynamic subtest B-eDP1: SUCCESS (1.931s) [168.494389] Starting dynamic subtest: C-eDP1 [170.338259] Dynamic subtest C-eDP1: SUCCESS (1.892s) [170.349854] Subtest basic-plain-flip: SUCCESS (5.733s) [171.729955] [109/162] (838s left) kms_force_connector_basic (force-connector-state) [171.828936] Starting subtest: force-connector-state [172.379821] Subtest force-connector-state: SUCCESS (0.552s) [173.696962] [110/162] (836s left) kms_force_connector_basic (force-edid) [173.797078] Starting subtest: force-edid [173.835525] Subtest force-edid: SUCCESS (0.038s) [174.092862] [111/162] (836s left) kms_force_connector_basic (force-load-detect) [174.190133] Starting subtest: force-load-detect [174.191994] Subtest force-load-detect: SKIP (0.000s) [174.385285] [112/162] (836s left) kms_force_connector_basic (prune-stale-modes) [174.481052] Starting subtest: prune-stale-modes [174.517025] Subtest prune-stale-modes: SUCCESS (0.035s) [174.794582] [113/162] (836s left) kms_frontbuffer_tracking (basic) [174.921833] Starting subtest: basic [178.414926] Subtest basic: SUCCESS (3.493s) [178.664785] [114/162] (832s left) kms_hdmi_inject (inject-audio) [179.077949] Starting subtest: inject-audio [179.205075] Subtest inject-audio: SUCCESS (0.128s) [180.089784] [115/162] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [180.213227] Starting subtest: compare-crc-sanitycheck-xr24 [180.216820] Starting dynamic subtest: pipe-A-eDP-1 [180.953665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s) [181.042694] Starting dynamic subtest: pipe-B-eDP-1 [182.431340] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s) [182.514176] Starting dynamic subtest: pipe-C-eDP-1 [183.822895] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s) [183.834236] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.613s) [184.775666] [116/162] (826s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [184.901073] Starting subtest: compare-crc-sanitycheck-nv12 [184.902151] Starting dynamic subtest: pipe-A-eDP-1 [184.904049] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [184.922583] Starting dynamic subtest: pipe-B-eDP-1 [184.925098] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [184.941601] Starting dynamic subtest: pipe-C-eDP-1 [184.944031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [184.946484] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s) [185.075319] [117/162] (826s left) kms_pipe_crc_basic (hang-read-crc)