[42.926188] Initializing watchdogs [42.926312] /dev/watchdog0 [42.933427] [001/171] (960s left) i915_module_load (load) [43.022624] Starting subtest: load [44.122238] Subtest load: SUCCESS (1.099s) [44.143278] [002/171] (959s left) core_auth (basic-auth) [44.290114] Starting subtest: basic-auth [44.291324] Subtest basic-auth: SUCCESS (0.001s) [44.399495] [003/171] (959s left) debugfs_test (read_all_entries) [44.510134] Starting subtest: read_all_entries [44.601160] Subtest read_all_entries: SUCCESS (0.092s) [44.703206] [004/171] (958s left) debugfs_test (basic-hwmon) [44.792089] Starting subtest: basic-hwmon [44.794055] Subtest basic-hwmon: SKIP (0.000s) [44.912989] [005/171] (958s left) fbdev (eof) [45.005188] Starting subtest: eof [45.006107] Subtest eof: SUCCESS (0.000s) [45.063612] [006/171] (958s left) fbdev (info) [45.142135] Starting subtest: info [45.143105] Subtest info: SUCCESS (0.000s) [45.208645] [007/171] (958s left) fbdev (nullptr) [45.304793] Starting subtest: nullptr [45.305781] Subtest nullptr: SUCCESS (0.000s) [45.358544] [008/171] (958s left) fbdev (read) [45.455072] Starting subtest: read [46.302850] Subtest read: SUCCESS (0.839s) [46.343857] [009/171] (957s left) fbdev (write) [46.438622] Starting subtest: write [46.859508] Subtest write: SUCCESS (0.412s) [46.899166] [010/171] (956s left) gem_basic (bad-close) [46.982740] Starting subtest: bad-close [46.984555] Subtest bad-close: SUCCESS (0.000s) [47.046113] [011/171] (956s left) gem_basic (create-close) [47.128960] Starting subtest: create-close [47.130928] Subtest create-close: SUCCESS (0.000s) [47.233221] [012/171] (956s left) gem_basic (create-fd-close) [47.343413] Starting subtest: create-fd-close [47.345319] Subtest create-fd-close: SUCCESS (0.000s) [47.464128] [013/171] (956s left) gem_busy (busy@all-engines) [47.567322] Starting subtest: busy [47.568436] Starting dynamic subtest: all-engines [47.611654] Dynamic subtest all-engines: SUCCESS (0.044s) [47.612977] Subtest busy: SUCCESS (0.044s) [48.023272] [014/171] (955s left) gem_close_race (basic-process) [48.128420] Starting subtest: basic-process [48.184196] Subtest basic-process: SUCCESS (0.056s) [48.385659] [015/171] (955s left) gem_close_race (basic-threads) [48.491209] Starting subtest: basic-threads [49.620424] Subtest basic-threads: SUCCESS (1.129s) [49.853786] [016/171] (953s left) gem_ctx_create (basic) [49.969045] Starting subtest: basic [49.969979] Subtest basic: SUCCESS (0.000s) [50.186746] [017/171] (953s left) gem_ctx_create (basic-files) [50.289565] Starting subtest: basic-files [52.305038] Subtest basic-files: SUCCESS (2.016s) [52.605444] [018/171] (951s left) gem_ctx_exec (basic) [52.710588] Starting subtest: basic [52.716743] Subtest basic: SUCCESS (0.006s) [52.839738] [019/171] (950s left) gem_exec_basic (basic) [52.954415] Starting subtest: basic [52.955470] Starting dynamic subtest: rcs0-smem [52.957437] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [52.964462] Starting dynamic subtest: bcs0-smem [52.965336] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [52.971938] Starting dynamic subtest: vcs0-smem [52.972826] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [52.979512] Starting dynamic subtest: vecs0-smem [52.980756] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [52.982042] Subtest basic: SUCCESS (0.007s) [53.186233] [020/171] (950s left) gem_exec_create (basic) [53.289297] Starting subtest: basic [53.290379] Starting dynamic subtest: smem [55.330953] Dynamic subtest smem: SUCCESS (2.041s) [55.332280] Subtest basic: SUCCESS (2.041s) [55.532380] [021/171] (948s left) gem_exec_fence (basic-busy) [55.799861] Starting subtest: basic-busy [55.801859] Starting dynamic subtest: rcs0 [55.832360] Dynamic subtest rcs0: SUCCESS (0.033s) [55.841606] Starting dynamic subtest: bcs0 [55.857353] Dynamic subtest bcs0: SUCCESS (0.025s) [55.865733] Starting dynamic subtest: vcs0 [55.885335] Dynamic subtest vcs0: SUCCESS (0.028s) [55.894383] Starting dynamic subtest: vecs0 [55.905560] Dynamic subtest vecs0: SUCCESS (0.020s) [55.906852] Subtest basic-busy: SUCCESS (0.106s) [56.526897] [022/171] (947s left) gem_exec_fence (basic-wait) [56.805698] Starting subtest: basic-wait [56.810326] Starting dynamic subtest: rcs0 [56.858341] Dynamic subtest rcs0: SUCCESS (0.051s) [56.905870] Starting dynamic subtest: bcs0 [56.909433] Dynamic subtest bcs0: SUCCESS (0.045s) [56.931247] Starting dynamic subtest: vcs0 [56.932698] Dynamic subtest vcs0: SUCCESS (0.027s) [56.943844] Starting dynamic subtest: vecs0 [56.954557] Dynamic subtest vecs0: SUCCESS (0.025s) [56.955923] Subtest basic-wait: SUCCESS (0.151s) [57.688581] [023/171] (946s left) gem_exec_fence (basic-await) [57.940436] Starting subtest: basic-await [57.942640] Starting dynamic subtest: rcs0 [58.036451] Dynamic subtest rcs0: SUCCESS (0.097s) [58.046860] Starting dynamic subtest: bcs0 [58.123522] Dynamic subtest bcs0: SUCCESS (0.087s) [58.136752] Starting dynamic subtest: vcs0 [58.222061] Dynamic subtest vcs0: SUCCESS (0.098s) [58.231160] Starting dynamic subtest: vecs0 [58.314054] Dynamic subtest vecs0: SUCCESS (0.092s) [58.315500] Subtest basic-await: SUCCESS (0.375s) [59.023426] [024/171] (944s left) gem_exec_fence (nb-await) [59.267251] Starting subtest: nb-await [59.269375] Starting dynamic subtest: rcs0 [59.338592] Dynamic subtest rcs0: SUCCESS (0.072s) [59.349505] Starting dynamic subtest: bcs0 [59.408397] Dynamic subtest bcs0: SUCCESS (0.064s) [59.440199] Starting dynamic subtest: vcs0 [59.499835] Dynamic subtest vcs0: SUCCESS (0.094s) [59.542746] Starting dynamic subtest: vecs0 [59.603721] Dynamic subtest vecs0: SUCCESS (0.103s) [59.605551] Subtest nb-await: SUCCESS (0.335s) [60.381237] [025/171] (943s left) gem_exec_gttfill (basic) [60.496706] Starting subtest: basic [69.734619] Subtest basic: SUCCESS (9.229s) [69.913856] [026/171] (934s left) gem_exec_parallel (engines) [70.070174] Starting subtest: engines [70.071582] Starting dynamic subtest: basic [72.393980] Dynamic subtest basic: SUCCESS (2.322s) [72.425551] Starting dynamic subtest: contexts [75.160070] Dynamic subtest contexts: SUCCESS (2.758s) [75.168029] Starting dynamic subtest: fds [78.724064] Dynamic subtest fds: SUCCESS (3.572s) [78.734733] Starting dynamic subtest: userptr [80.876922] Dynamic subtest userptr: SUCCESS (2.151s) [80.878566] Subtest engines: SUCCESS (10.805s) [81.091591] [027/171] (922s left) gem_exec_store (basic) [81.196158] Starting subtest: basic [81.247494] Subtest basic: SUCCESS (0.051s) [81.460168] [028/171] (922s left) gem_flink_basic (bad-flink) [81.552050] Starting subtest: bad-flink [81.553212] Subtest bad-flink: SUCCESS (0.000s) [81.624550] [029/171] (922s left) gem_flink_basic (bad-open) [81.716401] Starting subtest: bad-open [81.717517] Subtest bad-open: SUCCESS (0.000s) [81.791851] [030/171] (922s left) gem_flink_basic (basic) [81.881916] Starting subtest: basic [81.883022] Subtest basic: SUCCESS (0.000s) [82.003060] [031/171] (922s left) gem_flink_basic (double-flink) [82.094418] Starting subtest: double-flink [82.095433] Subtest double-flink: SUCCESS (0.000s) [82.208300] [032/171] (921s left) gem_flink_basic (flink-lifetime) [82.301143] Starting subtest: flink-lifetime [82.302082] Subtest flink-lifetime: SUCCESS (0.001s) [82.413326] [033/171] (921s left) gem_huc_copy (huc-copy) [82.514305] Starting subtest: huc-copy [82.516360] Subtest huc-copy: SKIP (0.000s) [82.645478] [034/171] (921s left) gem_linear_blits (basic) [82.869577] Starting subtest: basic [82.878724] Subtest basic: SUCCESS (0.009s) [83.038235] [035/171] (921s left) gem_mmap (basic) [83.204063] Starting subtest: basic [83.208804] Subtest basic: SUCCESS (0.000s) [83.293487] [036/171] (920s left) gem_mmap_gtt (basic) [83.386411] Starting subtest: basic [83.387492] Subtest basic: SUCCESS (0.001s) [83.448974] [037/171] (920s left) gem_render_linear_blits (basic) [83.545964] Starting subtest: basic [83.586861] Subtest basic: SUCCESS (0.041s) [83.629909] [038/171] (920s left) gem_render_tiled_blits (basic) [83.729718] Starting subtest: basic [83.773018] Subtest basic: SUCCESS (0.043s) [83.814091] [039/171] (920s left) gem_ringfill (basic-all) [84.103765] Starting subtest: basic-all [85.261650] Subtest basic-all: SUCCESS (1.150s) [85.419823] [040/171] (918s left) gem_softpin (allocator-basic) [85.521143] Starting subtest: allocator-basic [85.655372] Subtest allocator-basic: SUCCESS (0.126s) [85.763089] [041/171] (918s left) gem_softpin (allocator-basic-reserve) [85.861525] Starting subtest: allocator-basic-reserve [85.994142] Subtest allocator-basic-reserve: SUCCESS (0.124s) [86.118222] [042/171] (918s left) gem_softpin (safe-alignment) [86.221211] Starting subtest: safe-alignment [86.235851] Subtest safe-alignment: SUCCESS (0.014s) [86.370908] [043/171] (917s left) gem_sync (basic-all) [86.477892] Starting subtest: basic-all [88.535603] Subtest basic-all: SUCCESS (2.058s) [88.748241] [044/171] (915s left) gem_sync (basic-each) [88.853740] Starting subtest: basic-each [91.093475] Subtest basic-each: SUCCESS (2.240s) [91.363474] [045/171] (912s left) gem_tiled_blits (basic) [91.607266] Starting subtest: basic [91.631994] Subtest basic: SUCCESS (0.025s) [91.780755] [046/171] (912s left) gem_tiled_fence_blits (basic) [92.067409] Starting subtest: basic [92.079964] Subtest basic: SUCCESS (0.013s) [92.223775] [047/171] (912s left) gem_tiled_pread_basic [92.593126] [048/171] (911s left) gem_wait (busy@all-engines) [92.705111] Starting subtest: busy [92.706213] Starting dynamic subtest: all-engines [93.230343] Dynamic subtest all-engines: SUCCESS (0.525s) [93.231419] Subtest busy: SUCCESS (0.525s) [93.484398] [049/171] (910s left) gem_wait (wait@all-engines) [93.593118] Starting subtest: wait [93.594226] Starting dynamic subtest: all-engines [94.637089] Dynamic subtest all-engines: SUCCESS (1.042s) [94.640605] Subtest wait: SUCCESS (1.042s) [94.919772] [050/171] (909s left) i915_getparams_basic (basic-eu-total) [95.013406] Starting subtest: basic-eu-total [95.015483] Subtest basic-eu-total: SUCCESS (0.000s) [95.087401] [051/171] (909s left) i915_getparams_basic (basic-subslice-total) [95.184838] Starting subtest: basic-subslice-total [95.186974] Subtest basic-subslice-total: SUCCESS (0.000s) [95.253782] [052/171] (909s left) i915_hangman (error-state-basic) [95.370709] Starting subtest: error-state-basic [95.378418] Subtest error-state-basic: SUCCESS (0.008s) [95.465316] [053/171] (909s left) i915_pciid [95.630316] [054/171] (908s left) kms_addfb_basic (addfb25-bad-modifier) [95.762896] Starting subtest: addfb25-bad-modifier [95.764128] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.925606] [055/171] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.065108] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.065981] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.231209] [056/171] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.360995] Starting subtest: addfb25-modifier-no-flag [96.361943] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [96.534442] [057/171] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.660755] Starting subtest: addfb25-x-tiled-legacy [96.661888] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.819804] [058/171] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.948322] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.949313] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [97.119832] [059/171] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.285728] Starting subtest: addfb25-yf-tiled-legacy [97.286658] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [97.426877] [060/171] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [97.580603] Starting subtest: addfb25-y-tiled-legacy [97.581607] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [97.714871] [061/171] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.873733] Starting subtest: addfb25-y-tiled-small-legacy [97.874623] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [98.004648] [062/171] (906s left) kms_addfb_basic (bad-pitch-0) [98.091375] Starting subtest: bad-pitch-0 [98.092389] Subtest bad-pitch-0: SUCCESS (0.000s) [98.281647] [063/171] (906s left) kms_addfb_basic (bad-pitch-1024) [98.367387] Starting subtest: bad-pitch-1024 [98.368390] Subtest bad-pitch-1024: SUCCESS (0.000s) [98.561296] [064/171] (906s left) kms_addfb_basic (bad-pitch-128) [98.647209] Starting subtest: bad-pitch-128 [98.648269] Subtest bad-pitch-128: SUCCESS (0.000s) [98.859889] [065/171] (905s left) kms_addfb_basic (bad-pitch-256) [98.946361] Starting subtest: bad-pitch-256 [98.947348] Subtest bad-pitch-256: SUCCESS (0.000s) [99.141676] [066/171] (905s left) kms_addfb_basic (bad-pitch-32) [99.228326] Starting subtest: bad-pitch-32 [99.229310] Subtest bad-pitch-32: SUCCESS (0.000s) [99.422351] [067/171] (905s left) kms_addfb_basic (bad-pitch-63) [99.510125] Starting subtest: bad-pitch-63 [99.511110] Subtest bad-pitch-63: SUCCESS (0.000s) [99.704400] [068/171] (905s left) kms_addfb_basic (bad-pitch-65536) [99.788598] Starting subtest: bad-pitch-65536 [99.789737] Subtest bad-pitch-65536: SUCCESS (0.000s) [99.987517] [069/171] (904s left) kms_addfb_basic (bad-pitch-999) [100.071319] Starting subtest: bad-pitch-999 [100.072367] Subtest bad-pitch-999: SUCCESS (0.000s) [100.281948] [070/171] (904s left) kms_addfb_basic (basic) [100.368129] Starting subtest: basic [100.368964] Subtest basic: SUCCESS (0.000s) [100.570054] [071/171] (904s left) kms_addfb_basic (basic-x-tiled-legacy) [100.765108] Starting subtest: basic-x-tiled-legacy [100.766166] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [100.863835] [072/171] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [101.043189] Starting subtest: basic-y-tiled-legacy [101.044139] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [101.148798] [073/171] (903s left) kms_addfb_basic (bo-too-small) [101.269180] Starting subtest: bo-too-small [101.270195] Subtest bo-too-small: SUCCESS (0.000s) [101.428112] [074/171] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling) [101.548632] Starting subtest: bo-too-small-due-to-tiling [101.549492] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [101.717511] [075/171] (903s left) kms_addfb_basic (clobberred-modifier) [101.803219] Starting subtest: clobberred-modifier [101.804181] Subtest clobberred-modifier: SUCCESS (0.000s) [101.993480] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [102.173448] Starting subtest: framebuffer-vs-set-tiling [102.174381] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.280957] [077/171] (902s left) kms_addfb_basic (invalid-get-prop) [102.465942] Starting subtest: invalid-get-prop [102.467150] Subtest invalid-get-prop: SUCCESS (0.000s) [102.558532] [078/171] (902s left) kms_addfb_basic (invalid-get-prop-any) [102.747985] Starting subtest: invalid-get-prop-any [102.748890] Subtest invalid-get-prop-any: SUCCESS (0.000s) [102.843973] [079/171] (902s left) kms_addfb_basic (invalid-set-prop) [103.026206] Starting subtest: invalid-set-prop [103.027132] Subtest invalid-set-prop: SUCCESS (0.000s) [103.118291] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any) [103.305135] Starting subtest: invalid-set-prop-any [103.306107] Subtest invalid-set-prop-any: SUCCESS (0.000s) [103.400868] [081/171] (901s left) kms_addfb_basic (no-handle) [103.486447] Starting subtest: no-handle [103.487414] Subtest no-handle: SUCCESS (0.000s) [103.681689] [082/171] (901s left) kms_addfb_basic (size-max) [103.800308] Starting subtest: size-max [103.801312] Subtest size-max: SUCCESS (0.000s) [103.957055] [083/171] (901s left) kms_addfb_basic (small-bo) [104.083999] Starting subtest: small-bo [104.084844] Subtest small-bo: SUCCESS (0.000s) [104.255269] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch) [104.443135] Starting subtest: tile-pitch-mismatch [104.444053] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [104.550181] [085/171] (900s left) kms_addfb_basic (too-high) [104.668260] Starting subtest: too-high [104.669226] Subtest too-high: SUCCESS (0.001s) [104.829250] [086/171] (900s left) kms_addfb_basic (too-wide) [104.947765] Starting subtest: too-wide [104.948803] Subtest too-wide: SUCCESS (0.000s) [105.109594] [087/171] (900s left) kms_addfb_basic (unused-handle) [105.197828] Starting subtest: unused-handle [105.198821] Subtest unused-handle: SUCCESS (0.000s) [105.388399] [088/171] (899s left) kms_addfb_basic (unused-modifier) [105.476600] Starting subtest: unused-modifier [105.477579] Subtest unused-modifier: SUCCESS (0.000s) [105.666568] [089/171] (899s left) kms_addfb_basic (unused-offsets) [105.753375] Starting subtest: unused-offsets [105.754395] Subtest unused-offsets: SUCCESS (0.000s) [105.944411] [090/171] (899s left) kms_addfb_basic (unused-pitches) [106.033963] Starting subtest: unused-pitches [106.035023] Subtest unused-pitches: SUCCESS (0.000s) [106.235170] [091/171] (898s left) kms_busy (basic) [106.366049] Starting subtest: basic [106.367994] Starting dynamic subtest: flip [107.161724] Dynamic subtest flip: SUCCESS (0.793s) [107.170332] Starting dynamic subtest: modeset [110.829291] Dynamic subtest modeset: SUCCESS (3.667s) [110.830288] Subtest basic: SUCCESS (4.462s) [111.765410] [092/171] (893s left) kms_chamelium_hpd (dp-hpd-fast) [112.219246] Subtest dp-hpd-fast: SKIP (0.000s) [113.065781] [093/171] (892s left) kms_chamelium_edid (dp-edid-read) [113.496349] Subtest dp-edid-read: SKIP (0.000s) [114.414727] [094/171] (890s left) kms_chamelium_frames (dp-crc-fast) [114.834970] Subtest dp-crc-fast: SKIP (0.000s) [115.696497] [095/171] (889s left) kms_chamelium_hpd (hdmi-hpd-fast) [116.111140] Subtest hdmi-hpd-fast: SKIP (0.000s) [116.975207] [096/171] (888s left) kms_chamelium_edid (hdmi-edid-read) [117.412701] Subtest hdmi-edid-read: SKIP (0.000s) [118.323704] [097/171] (887s left) kms_chamelium_frames (hdmi-crc-fast) [118.754228] Subtest hdmi-crc-fast: SKIP (0.000s) [119.663894] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast) [120.087547] Subtest vga-hpd-fast: SKIP (0.000s) [120.947055] [099/171] (884s left) kms_chamelium_edid (vga-edid-read) [121.377165] Subtest vga-edid-read: SKIP (0.000s) [122.289375] [100/171] (883s left) kms_prop_blob (basic) [122.386494] Starting subtest: basic [122.387404] Subtest basic: SUCCESS (0.000s) [122.448674] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [122.578721] Starting subtest: basic-busy-flip-before-cursor-atomic [122.580641] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [122.661170] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [122.794596] Starting subtest: basic-busy-flip-before-cursor-legacy [122.796477] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [122.884165] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [123.020297] Starting subtest: basic-flip-after-cursor-atomic [124.343231] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.320s) [125.280779] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [125.408828] Starting subtest: basic-flip-after-cursor-legacy [126.674235] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.264s) [127.575942] [105/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [127.706519] Starting subtest: basic-flip-after-cursor-varying-size [128.972107] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.264s) [129.891381] [106/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [130.017757] Starting subtest: basic-flip-before-cursor-atomic [131.282033] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.264s) [132.184691] [107/171] (873s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [132.311984] Starting subtest: basic-flip-before-cursor-legacy [133.573332] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.261s) [134.489596] [108/171] (871s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [134.618423] Starting subtest: basic-flip-before-cursor-varying-size [135.957725] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.339s) [136.922150] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [137.031058] Starting subtest: basic-flip-vs-dpms [137.033485] Starting dynamic subtest: A-eDP1 [139.852393] Dynamic subtest A-eDP1: SUCCESS (2.817s) [139.863868] Starting dynamic subtest: B-eDP1 [142.225728] Dynamic subtest B-eDP1: SUCCESS (2.373s) [142.236762] Starting dynamic subtest: C-eDP1 [144.585554] Dynamic subtest C-eDP1: SUCCESS (2.358s) [144.588642] Subtest basic-flip-vs-dpms: SUCCESS (7.559s) [145.491694] [110/171] (860s left) kms_flip (basic-flip-vs-modeset) [145.603207] Starting subtest: basic-flip-vs-modeset [145.608668] Starting dynamic subtest: A-eDP1 [148.429518] Dynamic subtest A-eDP1: SUCCESS (2.818s) [148.444779] Starting dynamic subtest: B-eDP1 [150.797960] Dynamic subtest B-eDP1: SUCCESS (2.368s) [150.807504] Starting dynamic subtest: C-eDP1 [153.159484] Dynamic subtest C-eDP1: SUCCESS (2.360s) [153.162408] Subtest basic-flip-vs-modeset: SUCCESS (7.560s) [154.082078] [111/171] (851s left) kms_flip (basic-flip-vs-wf_vblank) [154.189301] Starting subtest: basic-flip-vs-wf_vblank [154.192188] Starting dynamic subtest: A-eDP1 [156.473598] Dynamic subtest A-eDP1: SUCCESS (2.281s) [156.486979] Starting dynamic subtest: B-eDP1 [158.778364] Dynamic subtest B-eDP1: SUCCESS (2.303s) [158.788142] Starting dynamic subtest: C-eDP1 [161.080414] Dynamic subtest C-eDP1: SUCCESS (2.301s) [161.084883] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.897s) [162.331493] [112/171] (843s left) kms_flip (basic-plain-flip) [162.441374] Starting subtest: basic-plain-flip [162.446926] Starting dynamic subtest: A-eDP1 [164.456830] Dynamic subtest A-eDP1: SUCCESS (2.006s) [164.496414] Starting dynamic subtest: B-eDP1 [166.508546] Dynamic subtest B-eDP1: SUCCESS (2.031s) [166.527663] Starting dynamic subtest: C-eDP1 [168.558344] Dynamic subtest C-eDP1: SUCCESS (2.048s) [168.568146] Subtest basic-plain-flip: SUCCESS (6.127s) [169.884143] [113/171] (835s left) kms_force_connector_basic (force-connector-state) [170.005364] Starting subtest: force-connector-state [170.604689] Subtest force-connector-state: SUCCESS (0.598s) [171.662246] [114/171] (834s left) kms_force_connector_basic (force-edid) [171.782745] Starting subtest: force-edid [171.810935] Subtest force-edid: SUCCESS (0.029s) [171.954091] [115/171] (833s left) kms_force_connector_basic (force-load-detect) [172.071552] Starting subtest: force-load-detect [172.073586] Subtest force-load-detect: SKIP (0.000s) [172.228070] [116/171] (833s left) kms_force_connector_basic (prune-stale-modes) [172.345973] Starting subtest: prune-stale-modes [172.378080] Subtest prune-stale-modes: SUCCESS (0.031s) [172.522927] [117/171] (833s left) kms_frontbuffer_tracking (basic) [172.649968] Starting subtest: basic [175.470959] Subtest basic: SUCCESS (2.823s) [175.580262] [118/171] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [175.701744] Starting subtest: compare-crc-sanitycheck [175.704148] Starting dynamic subtest: pipe-A-eDP-1 [176.346227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s) [176.358403] Starting dynamic subtest: pipe-B-eDP-1 [177.665940] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s) [177.676728] Starting dynamic subtest: pipe-C-eDP-1 [178.979873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s) [178.980786] Subtest compare-crc-sanitycheck: SUCCESS (3.277s) [179.927045] [119/171] (825s left) kms_pipe_crc_basic (hang-read-crc) [180.051389] Starting subtest: hang-read-crc [180.052404] Starting dynamic subtest: pipe-A-eDP-1 [182.297602] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.241s) [182.314307] Starting dynamic subtest: pipe-B-eDP-1 [185.230754] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.930s) [185.241646] Starting dynamic subtest: pipe-C-eDP-1 [188.145162] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.911s) [188.146850] Subtest hang-read-crc: SUCCESS (8.092s) [189.117369] [120/171] (816s left) kms_pipe_crc_basic (nonblocking-crc) [189.249660] Starting subtest: nonblocking-crc [189.250816] Starting dynamic subtest: pipe-A-eDP-1 [190.046857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s) [190.066042] Starting dynamic subtest: pipe-B-eDP-1 [191.558031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s) [191.569844] Starting dynamic subtest: pipe-C-eDP-1 [193.085439] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.526s) [193.086533] Subtest nonblocking-crc: SUCCESS (3.836s) [194.011736] [121/171] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.143493] Starting subtest: nonblocking-crc-frame-sequence [194.144512] Starting dynamic subtest: pipe-A-eDP-1 [194.940328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [194.949823] Starting dynamic subtest: pipe-B-eDP-1 [196.497774] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [196.511986] Starting dynamic subtest: pipe-C-eDP-1 [198.002540] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s) [198.003882] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.860s) [198.947092] [122/171] (806s left) kms_pipe_crc_basic (read-crc) [199.082933] Starting subtest: read-crc [199.085513] Starting dynamic subtest: pipe-A-eDP-1 [199.841571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s) [199.855317] Starting dynamic subtest: pipe-B-eDP-1 [201.328801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [201.349252] Starting dynamic subtest: pipe-C-eDP-1 [202.777880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.440s) [202.780669] Subtest read-crc: SUCCESS (3.693s) [203.671411] [123/171] (802s left) kms_pipe_crc_basic (read-crc-frame-sequence) [203.802297] Starting subtest: read-crc-frame-sequence [203.803341] Starting dynamic subtest: pipe-A-eDP-1 [204.531074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s) [204.546235] Starting dynamic subtest: pipe-B-eDP-1 [206.015325] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s) [206.035029] Starting dynamic subtest: pipe-C-eDP-1 [207.462543] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.442s) [207.463785] Subtest read-crc-frame-sequence: SUCCESS (3.659s) [208.407710] [124/171] (797s left) kms_psr (primary_page_flip) [208.537629] Starting subtest: primary_page_flip [210.494224] Subtest primary_page_flip: SUCCESS (1.956s) [211.422755] [125/171] (794s left) kms_psr (cursor_plane_move) [211.558180] Starting subtest: cursor_plane_move [213.512822] Subtest cursor_plane_move: SUCCESS (1.949s) [214.423866] [126/171] (791s left) kms_psr (sprite_plane_onoff) [214.559536] Starting subtest: sprite_plane_onoff [216.554655] Subtest sprite_plane_onoff: SUCCESS (1.992s) [217.499253] [127/171] (788s left) kms_psr (primary_mmap_gtt) [217.633444] Starting subtest: primary_mmap_gtt [219.609768] Subtest primary_mmap_gtt: SUCCESS (1.975s) [220.571421] [128/171] (785s left) kms_setmode (basic-clone-single-crtc) [220.666299] Starting subtest: basic-clone-single-crtc [220.669331] Subtest basic-clone-single-crtc: SKIP (0.000s) [220.745101] [129/171] (785s left) i915_pm_backlight (basic-brightness) [220.880204] Starting subtest: basic-brightness [221.010647] Starting dynamic subtest: eDP-1 [221.647197] Dynamic subtest eDP-1: SUCCESS (0.630s) [221.650263] Subtest basic-brightness: SUCCESS (0.753s) [222.524135] [130/171] (783s left) i915_pm_rpm (basic-pci-d3-state) [224.365474] Starting subtest: basic-pci-d3-state [228.869566] Subtest basic-pci-d3-state: SUCCESS (4.505s) [229.030362] [131/171] (776s left) i915_pm_rpm (basic-rte) [229.135088] Starting subtest: basic-rte [235.364868] Subtest basic-rte: SUCCESS (6.231s) [240.707990] [132/171] (765s left) i915_pm_rps (basic-api) [240.806806] Starting subtest: basic-api [240.811786] Subtest basic-api: SUCCESS (0.005s) [240.932998] [133/171] (765s left) prime_self_import (basic-llseek-bad) [241.032570] Starting subtest: basic-llseek-bad [241.036219] Subtest basic-llseek-bad: SUCCESS (0.002s) [241.132444] [134/171] (764s left) prime_self_import (basic-llseek-size) [241.222572] Starting subtest: basic-llseek-size [241.226110] Subtest basic-llseek-size: SUCCESS (0.003s) [241.355403] [135/171] (764s left) prime_self_import (basic-with_fd_dup) [241.446713] Starting subtest: basic-with_fd_dup [241.450258] Subtest basic-with_fd_dup: SUCCESS (0.003s) [241.578823] [136/171] (764s left) prime_self_import (basic-with_one_bo) [241.669358] Starting subtest: basic-with_one_bo [241.673052] Subtest basic-with_one_bo: SUCCESS (0.003s) [241.745578] [137/171] (764s left) prime_self_import (basic-with_one_bo_two_files) [241.837961] Starting subtest: basic-with_one_bo_two_files [241.840988] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [241.949105] [138/171] (764s left) prime_self_import (basic-with_two_bos) [242.046285] Starting subtest: basic-with_two_bos [242.049697] Subtest basic-with_two_bos: SUCCESS (0.003s) [242.185359] [139/171] (764s left) prime_vgem (basic-fence-flip) [242.309358] Starting subtest: basic-fence-flip [242.802045] Subtest basic-fence-flip: SUCCESS (0.492s) [242.935483] [140/171] (763s left) prime_vgem (basic-fence-mmap) [243.064492] Starting subtest: basic-fence-mmap [243.095082] Subtest basic-fence-mmap: SUCCESS (0.031s) [243.169032] [141/171] (763s left) prime_vgem (basic-fence-read) [243.289945] Starting subtest: basic-fence-read [243.342035] Subtest basic-fence-read: SUCCESS (0.052s) [243.443528] [142/171] (762s left) prime_vgem (basic-gtt) [243.570184] Starting subtest: basic-gtt [243.585691] Subtest basic-gtt: SUCCESS (0.015s) [243.688793] [143/171] (762s left) prime_vgem (basic-read) [243.826509] Starting subtest: basic-read [243.851458] Subtest basic-read: SUCCESS (0.025s) [243.966851] [144/171] (762s left) prime_vgem (basic-write) [244.107107] Starting subtest: basic-write [244.135056] Subtest basic-write: SUCCESS (0.028s) [244.200759] [145/171] (762s left) prime_vgem (basic-userptr) [244.316155] Starting subtest: basic-userptr [244.325852] Subtest basic-userptr: SKIP (0.009s) [244.448534] [146/171] (761s left) vgem_basic (setversion) [244.567174] Starting subtest: setversion [244.569510] Subtest setversion: SUCCESS (0.000s) [244.628646] [147/171] (761s left) vgem_basic (create) [244.731633] Starting subtest: create [244.732627] Subtest create: SUCCESS (0.000s) [244.789304] [148/171] (761s left) vgem_basic (debugfs) [244.898661] Starting subtest: debugfs [244.899773] Subtest debugfs: SUCCESS (0.001s) [244.959600] [149/171] (761s left) vgem_basic (dmabuf-export) [245.065100] Starting subtest: dmabuf-export [245.083654] Subtest dmabuf-export: SUCCESS (0.016s) [245.200949] [150/171] (761s left) vgem_basic (dmabuf-fence) [245.320914] Starting subtest: dmabuf-fence [245.321951] Subtest dmabuf-fence: SUCCESS (0.001s) [245.381251] [151/171] (761s left) vgem_basic (dmabuf-fence-before) [245.487130] Starting subtest: dmabuf-fence-before [245.488098] Subtest dmabuf-fence-before: SUCCESS (0.000s) [245.544232] [152/171] (760s left) vgem_basic (dmabuf-mmap) [245.637148] Starting subtest: dmabuf-mmap [245.656121] Subtest dmabuf-mmap: SUCCESS (0.019s) [245.711682] [153/171] (760s left) vgem_basic (mmap) [245.820704] Starting subtest: mmap [245.832388] Subtest mmap: SUCCESS (0.012s) [245.880048] [154/171] (760s left) vgem_basic (second-client) [245.989251] Starting subtest: second-client [246.039518] Subtest second-client: SUCCESS (0.048s) [246.095623] [155/171] (760s left) vgem_basic (sysfs) [246.205934] Starting subtest: sysfs [246.206829] Subtest sysfs: SUCCESS (0.001s) [246.264969] [156/171] (760s left) core_hotunplug (unbind-rebind) [246.370760] Starting subtest: unbind-rebind [248.574960] Subtest unbind-rebind: SUCCESS (2.204s) [248.601117] [157/171] (758s left) vgem_basic (unload) [248.708803] Starting subtest: unload [277.644519] Subtest unload: SUCCESS (28.902s) [277.712394] [158/171] (728s left) i915_module_load (reload) [277.804080] Starting subtest: reload [280.729771] Subtest reload: SUCCESS (2.926s) [280.766930] [159/171] (725s left) gem_lmem_swapping (basic) [280.962536] Subtest basic: SKIP (0.000s) [280.998567] [160/171] (725s left) gem_lmem_swapping (parallel-random-engines) [281.094201] Subtest parallel-random-engines: SKIP (0.000s) [281.134864] [161/171] (725s left) gem_lmem_swapping (random-engines) [281.231047] Subtest random-engines: SKIP (0.000s) [281.265113] [162/171] (725s left) gem_lmem_swapping (verify-random) [281.363102] Subtest verify-random: SKIP (0.000s) [281.398490] [163/171] (725s left) i915_pm_rpm (module-reload) [284.039067] Starting subtest: module-reload [301.262361] Subtest module-reload: SUCCESS (17.217s) [301.275662] [164/171] (705s left) i915_selftest (live) [301.375599] Starting subtest: live [301.376745] Starting dynamic subtest: sanitycheck [303.011464] Dynamic subtest sanitycheck: SUCCESS (1.626s) [303.018840] Starting dynamic subtest: uncore [304.613704] Dynamic subtest uncore: SUCCESS (1.601s) [304.621082] Starting dynamic subtest: workarounds [306.463785] Dynamic subtest workarounds: SUCCESS (1.857s) [306.472496] Starting dynamic subtest: gt_engines [308.596509] Dynamic subtest gt_engines: SUCCESS (2.124s) [308.603976] Starting dynamic subtest: gt_timelines [318.225423] Dynamic subtest gt_timelines: SUCCESS (9.628s) [318.236541] Starting dynamic subtest: gt_contexts [319.909501] Dynamic subtest gt_contexts: SUCCESS (1.683s) [319.916754] Starting dynamic subtest: gt_lrc [324.256838] Dynamic subtest gt_lrc: SUCCESS (4.346s) [324.264406] Starting dynamic subtest: gt_mocs [325.938445] Dynamic subtest gt_mocs: SUCCESS (1.681s) [325.945862] Starting dynamic subtest: gt_pm [331.869691] Dynamic subtest gt_pm: SUCCESS (5.930s) [331.877184] Starting dynamic subtest: gt_heartbeat [333.612439] Dynamic subtest gt_heartbeat: SUCCESS (1.742s) [333.620074] Starting dynamic subtest: requests [340.991723] Dynamic subtest requests: SUCCESS (7.378s) [341.003041] Starting dynamic subtest: migrate [345.458392] Dynamic subtest migrate: SUCCESS (4.466s) [345.465776] Starting dynamic subtest: active [347.048435] Dynamic subtest active: SUCCESS (1.589s) [347.056163] Starting dynamic subtest: objects [349.803358] Dynamic subtest objects: SUCCESS (2.754s) [349.814550] Starting dynamic subtest: mman [354.975376] Dynamic subtest mman: SUCCESS (5.171s) [354.986566] Starting dynamic subtest: dmabuf [356.578436] Dynamic subtest dmabuf: SUCCESS (1.602s) [356.589733] Starting dynamic subtest: vma [358.192521] Dynamic subtest vma: SUCCESS (1.613s) [358.200169] Starting dynamic subtest: coherency [360.853805] Dynamic subtest coherency: SUCCESS (2.660s) [360.861389] Starting dynamic subtest: gtt [371.204425] Dynamic subtest gtt: SUCCESS (10.350s) [371.212196] Starting dynamic subtest: gem [373.090466] Dynamic subtest gem: SUCCESS (1.885s) [373.101810] Starting dynamic subtest: evict [376.226216] Dynamic subtest evict: SUCCESS (3.137s) [376.234216] Starting dynamic subtest: hugepages [382.193497] Dynamic subtest hugepages: SUCCESS (5.964s) [382.201605] Starting dynamic subtest: gem_contexts [396.587818] Dynamic subtest gem_contexts: SUCCESS (14.393s) [396.599202] Starting dynamic subtest: client [398.256391] Dynamic subtest client: SUCCESS (1.668s) [398.267777] Starting dynamic subtest: gem_migrate [399.849687] Dynamic subtest gem_migrate: SUCCESS (1.592s) [399.857343] Starting dynamic subtest: reset [402.159469] Dynamic subtest reset: SUCCESS (2.309s) [402.170828] Starting dynamic subtest: memory_region [403.755594] Dynamic subtest memory_region: SUCCESS (1.595s) [403.763179] Starting dynamic subtest: hangcheck [427.956800] Dynamic subtest hangcheck: SUCCESS (24.200s) [427.964469] Starting dynamic subtest: execlists [437.241398] Dynamic subtest execlists: SUCCESS (9.284s) [437.249277] Starting dynamic subtest: ring_submission [438.818374] Dynamic subtest ring_submission: SUCCESS (1.576s) [438.826054] Starting dynamic subtest: perf [440.562495] Dynamic subtest perf: SUCCESS (1.743s) [440.570123] Starting dynamic subtest: slpc [442.152621] Dynamic subtest slpc: SUCCESS (1.589s) [442.164030] Starting dynamic subtest: guc [443.744485] Dynamic subtest guc: SUCCESS (1.591s) [443.752170] Starting dynamic subtest: guc_multi_lrc [445.328528] Dynamic subtest guc_multi_lrc: SUCCESS (1.583s) [445.336403] Starting dynamic subtest: guc_hang [446.956404] Dynamic subtest guc_hang: SUCCESS (1.627s) [446.963724] Starting dynamic subtest: late_gt_pm [448.618953] Dynamic subtest late_gt_pm: SUCCESS (1.661s) [448.621693] Subtest live: SUCCESS (147.234s) [448.696057] [165/171] (558s left) dmabuf (all-tests) [448.798458] Starting subtest: all-tests [448.799859] Starting dynamic subtest: sanitycheck [448.824340] Dynamic subtest sanitycheck: SUCCESS (0.025s) [448.833323] Starting dynamic subtest: dma_fence [448.960464] Dynamic subtest dma_fence: SUCCESS (0.135s) [448.969164] Starting dynamic subtest: dma_fence_chain [464.725025] Dynamic subtest dma_fence_chain: SUCCESS (15.755s) [464.731772] Starting dynamic subtest: dma_fence_unwrap [464.741362] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [464.751150] Starting dynamic subtest: dma_resv [464.762239] Dynamic subtest dma_resv: SUCCESS (0.020s) [464.763237] Subtest all-tests: SUCCESS (15.964s) [464.780457] [166/171] (542s left) i915_suspend (basic-s2idle-without-i915) [464.872438] Starting subtest: basic-s2idle-without-i915 [484.895995] Subtest basic-s2idle-without-i915: SUCCESS (3.890s) [487.268586] [167/171] (537s left) i915_suspend (basic-s3-without-i915) [487.371123] Starting subtest: basic-s3-without-i915 [507.596224] Subtest basic-s3-without-i915: SUCCESS (3.649s) [509.979914] [168/171] (533s left) gem_exec_suspend (basic-s0) [510.127854] Starting subtest: basic-S0 [510.128841] Starting dynamic subtest: smem [528.937434] Dynamic subtest smem: SUCCESS (3.170s) [528.938375] Subtest basic-S0: SUCCESS (3.171s) [531.115292] [169/171] (530s left) gem_exec_suspend (basic-s3) [531.232154] Starting subtest: basic-S3 [531.233260] Starting dynamic subtest: smem [552.202368] Dynamic subtest smem: SUCCESS (4.443s) [552.203329] Subtest basic-S3: SUCCESS (4.444s) [554.369185] [170/171] (525s left) kms_chamelium_hpd (common-hpd-after-suspend) [554.811765] Subtest common-hpd-after-suspend: SKIP (0.000s) [555.667641] [171/171] (524s left) kms_pipe_crc_basic (suspend-read-crc) [555.798005] Starting subtest: suspend-read-crc [555.800519] Starting dynamic subtest: pipe-A-eDP-1 [576.484775] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.816s) [576.497096] Starting dynamic subtest: pipe-B-eDP-1 [607.088891] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.194s) [607.101938] Starting dynamic subtest: pipe-C-eDP-1 [628.242502] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.252s) [628.243492] Subtest suspend-read-crc: SUCCESS (22.269s) [631.133202] Closing watchdogs Done.