[43.230612] Initializing watchdogs [43.230733] /dev/watchdog0 [43.237264] [001/171] (960s left) i915_module_load (load) [43.446893] Starting subtest: load [44.401997] Subtest load: SUCCESS (0.955s) [44.435817] [002/171] (959s left) core_auth (basic-auth) [44.565131] Starting subtest: basic-auth [44.566114] Subtest basic-auth: SUCCESS (0.001s) [44.634994] [003/171] (959s left) debugfs_test (read_all_entries) [44.771396] Starting subtest: read_all_entries [44.852959] Subtest read_all_entries: SUCCESS (0.082s) [44.961339] [004/171] (958s left) debugfs_test (basic-hwmon) [45.051750] Starting subtest: basic-hwmon [45.053616] Subtest basic-hwmon: SKIP (0.000s) [45.161547] [005/171] (958s left) fbdev (eof) [45.259738] Starting subtest: eof [45.260744] Subtest eof: SUCCESS (0.000s) [45.312921] [006/171] (958s left) fbdev (info) [45.397438] Starting subtest: info [45.398399] Subtest info: SUCCESS (0.000s) [45.463300] [007/171] (958s left) fbdev (nullptr) [45.559572] Starting subtest: nullptr [45.560562] Subtest nullptr: SUCCESS (0.000s) [45.611256] [008/171] (958s left) fbdev (read) [45.710371] Starting subtest: read [46.556647] Subtest read: SUCCESS (0.837s) [46.600807] [009/171] (957s left) fbdev (write) [46.693365] Starting subtest: write [47.119915] Subtest write: SUCCESS (0.417s) [47.192790] [010/171] (956s left) gem_basic (bad-close) [47.278220] Starting subtest: bad-close [47.280092] Subtest bad-close: SUCCESS (0.000s) [47.341882] [011/171] (956s left) gem_basic (create-close) [47.429250] Starting subtest: create-close [47.431215] Subtest create-close: SUCCESS (0.000s) [47.572637] [012/171] (956s left) gem_basic (create-fd-close) [47.670161] Starting subtest: create-fd-close [47.671993] Subtest create-fd-close: SUCCESS (0.000s) [47.799125] [013/171] (956s left) gem_busy (busy@all-engines) [47.902087] Starting subtest: busy [47.903034] Starting dynamic subtest: all-engines [47.946690] Dynamic subtest all-engines: SUCCESS (0.045s) [47.947585] Subtest busy: SUCCESS (0.045s) [48.380684] [014/171] (955s left) gem_close_race (basic-process) [48.487400] Starting subtest: basic-process [48.545187] Subtest basic-process: SUCCESS (0.059s) [48.771700] [015/171] (955s left) gem_close_race (basic-threads) [48.884820] Starting subtest: basic-threads [50.038063] Subtest basic-threads: SUCCESS (1.153s) [50.266504] [016/171] (953s left) gem_ctx_create (basic) [50.373359] Starting subtest: basic [50.374633] Subtest basic: SUCCESS (0.000s) [50.607670] [017/171] (953s left) gem_ctx_create (basic-files) [50.717965] Starting subtest: basic-files [52.735979] Subtest basic-files: SUCCESS (2.018s) [52.987407] [018/171] (951s left) gem_ctx_exec (basic) [53.094399] Starting subtest: basic [53.098754] Subtest basic: SUCCESS (0.005s) [53.224086] [019/171] (950s left) gem_exec_basic (basic) [53.338239] Starting subtest: basic [53.339362] Starting dynamic subtest: rcs0-smem [53.340395] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [53.348810] Starting dynamic subtest: bcs0-smem [53.349796] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [53.356683] Starting dynamic subtest: vcs0-smem [53.357976] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [53.364672] Starting dynamic subtest: vecs0-smem [53.365961] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [53.367254] Subtest basic: SUCCESS (0.005s) [53.577014] [020/171] (950s left) gem_exec_create (basic) [53.676827] Starting subtest: basic [53.677781] Starting dynamic subtest: smem [55.716489] Dynamic subtest smem: SUCCESS (2.040s) [55.717511] Subtest basic: SUCCESS (2.040s) [55.936021] [021/171] (948s left) gem_exec_fence (basic-busy) [56.197477] Starting subtest: basic-busy [56.199124] Starting dynamic subtest: rcs0 [56.228339] Dynamic subtest rcs0: SUCCESS (0.031s) [56.236527] Starting dynamic subtest: bcs0 [56.258308] Dynamic subtest bcs0: SUCCESS (0.030s) [56.266244] Starting dynamic subtest: vcs0 [56.277454] Dynamic subtest vcs0: SUCCESS (0.019s) [56.285068] Starting dynamic subtest: vecs0 [56.303395] Dynamic subtest vecs0: SUCCESS (0.026s) [56.304879] Subtest basic-busy: SUCCESS (0.107s) [56.990714] [022/171] (947s left) gem_exec_fence (basic-wait) [57.256880] Starting subtest: basic-wait [57.258845] Starting dynamic subtest: rcs0 [57.294431] Dynamic subtest rcs0: SUCCESS (0.038s) [57.305876] Starting dynamic subtest: bcs0 [57.318582] Dynamic subtest bcs0: SUCCESS (0.024s) [57.329576] Starting dynamic subtest: vcs0 [57.348459] Dynamic subtest vcs0: SUCCESS (0.030s) [57.359227] Starting dynamic subtest: vecs0 [57.370627] Dynamic subtest vecs0: SUCCESS (0.022s) [57.371758] Subtest basic-wait: SUCCESS (0.115s) [58.021505] [023/171] (946s left) gem_exec_fence (basic-await) [58.270643] Starting subtest: basic-await [58.272889] Starting dynamic subtest: rcs0 [58.366473] Dynamic subtest rcs0: SUCCESS (0.096s) [58.375957] Starting dynamic subtest: bcs0 [58.458522] Dynamic subtest bcs0: SUCCESS (0.091s) [58.467995] Starting dynamic subtest: vcs0 [58.554512] Dynamic subtest vcs0: SUCCESS (0.096s) [58.570260] Starting dynamic subtest: vecs0 [58.674192] Dynamic subtest vecs0: SUCCESS (0.119s) [58.675904] Subtest basic-await: SUCCESS (0.404s) [59.456986] [024/171] (944s left) gem_exec_fence (nb-await) [59.701849] Starting subtest: nb-await [59.703763] Starting dynamic subtest: rcs0 [59.775201] Dynamic subtest rcs0: SUCCESS (0.074s) [59.782723] Starting dynamic subtest: bcs0 [59.839890] Dynamic subtest bcs0: SUCCESS (0.062s) [59.876460] Starting dynamic subtest: vcs0 [59.935247] Dynamic subtest vcs0: SUCCESS (0.094s) [59.978748] Starting dynamic subtest: vecs0 [60.041357] Dynamic subtest vecs0: SUCCESS (0.105s) [60.044669] Subtest nb-await: SUCCESS (0.338s) [60.803905] [025/171] (943s left) gem_exec_gttfill (basic) [60.912763] Starting subtest: basic [69.893036] Subtest basic: SUCCESS (8.972s) [70.074080] [026/171] (934s left) gem_exec_parallel (engines) [70.232946] Starting subtest: engines [70.234085] Starting dynamic subtest: basic [72.609127] Dynamic subtest basic: SUCCESS (2.376s) [72.617549] Starting dynamic subtest: contexts [75.458772] Dynamic subtest contexts: SUCCESS (2.840s) [75.483304] Starting dynamic subtest: fds [78.926865] Dynamic subtest fds: SUCCESS (3.477s) [78.935481] Starting dynamic subtest: userptr [81.251106] Dynamic subtest userptr: SUCCESS (2.324s) [81.252731] Subtest engines: SUCCESS (11.018s) [81.467230] [027/171] (922s left) gem_exec_store (basic) [81.575789] Starting subtest: basic [81.631849] Subtest basic: SUCCESS (0.056s) [81.864373] [028/171] (922s left) gem_flink_basic (bad-flink) [81.962577] Starting subtest: bad-flink [81.963511] Subtest bad-flink: SUCCESS (0.000s) [82.061310] [029/171] (922s left) gem_flink_basic (bad-open) [82.163245] Starting subtest: bad-open [82.164172] Subtest bad-open: SUCCESS (0.000s) [82.290456] [030/171] (922s left) gem_flink_basic (basic) [82.384582] Starting subtest: basic [82.385637] Subtest basic: SUCCESS (0.000s) [82.502313] [031/171] (921s left) gem_flink_basic (double-flink) [82.609382] Starting subtest: double-flink [82.610307] Subtest double-flink: SUCCESS (0.000s) [82.728218] [032/171] (921s left) gem_flink_basic (flink-lifetime) [82.816275] Starting subtest: flink-lifetime [82.817313] Subtest flink-lifetime: SUCCESS (0.001s) [82.940643] [033/171] (921s left) gem_huc_copy (huc-copy) [83.049080] Starting subtest: huc-copy [83.050924] Subtest huc-copy: SKIP (0.000s) [83.181840] [034/171] (921s left) gem_linear_blits (basic) [83.413212] Starting subtest: basic [83.423466] Subtest basic: SUCCESS (0.010s) [83.575215] [035/171] (920s left) gem_mmap (basic) [83.717359] Starting subtest: basic [83.722129] Subtest basic: SUCCESS (0.000s) [83.811559] [036/171] (920s left) gem_mmap_gtt (basic) [83.911399] Starting subtest: basic [83.912474] Subtest basic: SUCCESS (0.001s) [84.018881] [037/171] (920s left) gem_render_linear_blits (basic) [84.130573] Starting subtest: basic [84.171029] Subtest basic: SUCCESS (0.040s) [84.211983] [038/171] (920s left) gem_render_tiled_blits (basic) [84.311381] Starting subtest: basic [84.356093] Subtest basic: SUCCESS (0.044s) [84.395570] [039/171] (920s left) gem_ringfill (basic-all) [84.679627] Starting subtest: basic-all [85.833854] Subtest basic-all: SUCCESS (1.146s) [85.919055] [040/171] (918s left) gem_softpin (allocator-basic) [86.030836] Starting subtest: allocator-basic [86.166733] Subtest allocator-basic: SUCCESS (0.127s) [86.297820] [041/171] (918s left) gem_softpin (allocator-basic-reserve) [86.395180] Starting subtest: allocator-basic-reserve [86.527955] Subtest allocator-basic-reserve: SUCCESS (0.124s) [86.664597] [042/171] (917s left) gem_softpin (safe-alignment) [86.758778] Starting subtest: safe-alignment [86.773506] Subtest safe-alignment: SUCCESS (0.015s) [86.909204] [043/171] (917s left) gem_sync (basic-all) [87.014255] Starting subtest: basic-all [89.078464] Subtest basic-all: SUCCESS (2.066s) [89.323900] [044/171] (915s left) gem_sync (basic-each) [89.434854] Starting subtest: basic-each [91.598726] Subtest basic-each: SUCCESS (2.164s) [91.892358] [045/171] (912s left) gem_tiled_blits (basic) [92.127524] Starting subtest: basic [92.155567] Subtest basic: SUCCESS (0.027s) [92.310279] [046/171] (912s left) gem_tiled_fence_blits (basic) [92.601713] Starting subtest: basic [92.613707] Subtest basic: SUCCESS (0.013s) [92.751644] [047/171] (912s left) gem_tiled_pread_basic [93.111806] [048/171] (911s left) gem_wait (busy@all-engines) [93.237717] Starting subtest: busy [93.238766] Starting dynamic subtest: all-engines [93.771397] Dynamic subtest all-engines: SUCCESS (0.534s) [93.772403] Subtest busy: SUCCESS (0.534s) [94.015195] [049/171] (910s left) gem_wait (wait@all-engines) [94.124432] Starting subtest: wait [94.125600] Starting dynamic subtest: all-engines [95.175648] Dynamic subtest all-engines: SUCCESS (1.048s) [95.179128] Subtest wait: SUCCESS (1.048s) [95.433486] [050/171] (909s left) i915_getparams_basic (basic-eu-total) [95.530167] Starting subtest: basic-eu-total [95.532189] Subtest basic-eu-total: SUCCESS (0.000s) [95.635358] [051/171] (909s left) i915_getparams_basic (basic-subslice-total) [95.741100] Starting subtest: basic-subslice-total [95.742934] Subtest basic-subslice-total: SUCCESS (0.000s) [95.843636] [052/171] (909s left) i915_hangman (error-state-basic) [95.959828] Starting subtest: error-state-basic [95.966992] Subtest error-state-basic: SUCCESS (0.007s) [96.051563] [053/171] (908s left) i915_pciid [96.223330] [054/171] (908s left) kms_addfb_basic (addfb25-bad-modifier) [96.357513] Starting subtest: addfb25-bad-modifier [96.358613] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [96.521684] [055/171] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.651550] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.652656] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.816585] [056/171] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.946130] Starting subtest: addfb25-modifier-no-flag [96.947020] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [97.127018] [057/171] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy) [97.248235] Starting subtest: addfb25-x-tiled-legacy [97.249361] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [97.421200] [058/171] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [97.549104] Starting subtest: addfb25-x-tiled-mismatch-legacy [97.550022] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [97.728249] [059/171] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.889680] Starting subtest: addfb25-yf-tiled-legacy [97.890722] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [98.016855] [060/171] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [98.168697] Starting subtest: addfb25-y-tiled-legacy [98.169832] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [98.295342] [061/171] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [98.445962] Starting subtest: addfb25-y-tiled-small-legacy [98.447097] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [98.585475] [062/171] (906s left) kms_addfb_basic (bad-pitch-0) [98.672463] Starting subtest: bad-pitch-0 [98.673514] Subtest bad-pitch-0: SUCCESS (0.000s) [98.873191] [063/171] (906s left) kms_addfb_basic (bad-pitch-1024) [98.959306] Starting subtest: bad-pitch-1024 [98.960195] Subtest bad-pitch-1024: SUCCESS (0.000s) [99.177047] [064/171] (905s left) kms_addfb_basic (bad-pitch-128) [99.261956] Starting subtest: bad-pitch-128 [99.262838] Subtest bad-pitch-128: SUCCESS (0.000s) [99.483254] [065/171] (905s left) kms_addfb_basic (bad-pitch-256) [99.564341] Starting subtest: bad-pitch-256 [99.565358] Subtest bad-pitch-256: SUCCESS (0.000s) [99.778244] [066/171] (905s left) kms_addfb_basic (bad-pitch-32) [99.860436] Starting subtest: bad-pitch-32 [99.861536] Subtest bad-pitch-32: SUCCESS (0.000s) [100.058517] [067/171] (905s left) kms_addfb_basic (bad-pitch-63) [100.142141] Starting subtest: bad-pitch-63 [100.143190] Subtest bad-pitch-63: SUCCESS (0.000s) [100.341619] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536) [100.427237] Starting subtest: bad-pitch-65536 [100.428269] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.621619] [069/171] (904s left) kms_addfb_basic (bad-pitch-999) [100.708180] Starting subtest: bad-pitch-999 [100.709189] Subtest bad-pitch-999: SUCCESS (0.000s) [100.897203] [070/171] (904s left) kms_addfb_basic (basic) [100.981414] Starting subtest: basic [100.982496] Subtest basic: SUCCESS (0.000s) [101.175840] [071/171] (904s left) kms_addfb_basic (basic-x-tiled-legacy) [101.366825] Starting subtest: basic-x-tiled-legacy [101.367874] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.462780] [072/171] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [101.654448] Starting subtest: basic-y-tiled-legacy [101.655441] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [101.750327] [073/171] (903s left) kms_addfb_basic (bo-too-small) [101.871303] Starting subtest: bo-too-small [101.872384] Subtest bo-too-small: SUCCESS (0.000s) [102.039754] [074/171] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling) [102.159063] Starting subtest: bo-too-small-due-to-tiling [102.160154] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [102.315644] [075/171] (903s left) kms_addfb_basic (clobberred-modifier) [102.399091] Starting subtest: clobberred-modifier [102.399950] Subtest clobberred-modifier: SUCCESS (0.000s) [102.603659] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [102.783242] Starting subtest: framebuffer-vs-set-tiling [102.784170] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.880569] [077/171] (902s left) kms_addfb_basic (invalid-get-prop) [103.058427] Starting subtest: invalid-get-prop [103.059434] Subtest invalid-get-prop: SUCCESS (0.000s) [103.160967] [078/171] (902s left) kms_addfb_basic (invalid-get-prop-any) [103.345296] Starting subtest: invalid-get-prop-any [103.346271] Subtest invalid-get-prop-any: SUCCESS (0.000s) [103.439951] [079/171] (902s left) kms_addfb_basic (invalid-set-prop) [103.624193] Starting subtest: invalid-set-prop [103.625202] Subtest invalid-set-prop: SUCCESS (0.000s) [103.720467] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any) [103.901767] Starting subtest: invalid-set-prop-any [103.902838] Subtest invalid-set-prop-any: SUCCESS (0.000s) [103.992060] [081/171] (901s left) kms_addfb_basic (no-handle) [104.077456] Starting subtest: no-handle [104.078486] Subtest no-handle: SUCCESS (0.000s) [104.273090] [082/171] (901s left) kms_addfb_basic (size-max) [104.391253] Starting subtest: size-max [104.392246] Subtest size-max: SUCCESS (0.000s) [104.546628] [083/171] (900s left) kms_addfb_basic (small-bo) [104.661975] Starting subtest: small-bo [104.663216] Subtest small-bo: SUCCESS (0.000s) [104.821507] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch) [105.000456] Starting subtest: tile-pitch-mismatch [105.001466] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [105.099073] [085/171] (900s left) kms_addfb_basic (too-high) [105.218322] Starting subtest: too-high [105.219335] Subtest too-high: SUCCESS (0.001s) [105.372825] [086/171] (900s left) kms_addfb_basic (too-wide) [105.497100] Starting subtest: too-wide [105.498112] Subtest too-wide: SUCCESS (0.000s) [105.661381] [087/171] (899s left) kms_addfb_basic (unused-handle) [105.745367] Starting subtest: unused-handle [105.746299] Subtest unused-handle: SUCCESS (0.000s) [105.947404] [088/171] (899s left) kms_addfb_basic (unused-modifier) [106.030228] Starting subtest: unused-modifier [106.031148] Subtest unused-modifier: SUCCESS (0.000s) [106.238345] [089/171] (899s left) kms_addfb_basic (unused-offsets) [106.323280] Starting subtest: unused-offsets [106.324177] Subtest unused-offsets: SUCCESS (0.000s) [106.531084] [090/171] (899s left) kms_addfb_basic (unused-pitches) [106.614503] Starting subtest: unused-pitches [106.615625] Subtest unused-pitches: SUCCESS (0.000s) [106.823563] [091/171] (898s left) kms_busy (basic) [106.957538] Starting subtest: basic [106.958593] Starting dynamic subtest: flip [107.784127] Dynamic subtest flip: SUCCESS (0.821s) [107.793872] Starting dynamic subtest: modeset [111.399574] Dynamic subtest modeset: SUCCESS (3.620s) [111.400648] Subtest basic: SUCCESS (4.441s) [112.347185] [092/171] (893s left) kms_chamelium_hpd (dp-hpd-fast) [112.775507] Subtest dp-hpd-fast: SKIP (0.000s) [113.642601] [093/171] (892s left) kms_chamelium_edid (dp-edid-read) [114.070034] Subtest dp-edid-read: SKIP (0.000s) [114.990106] [094/171] (890s left) kms_chamelium_frames (dp-crc-fast) [115.407678] Subtest dp-crc-fast: SKIP (0.000s) [116.277103] [095/171] (889s left) kms_chamelium_hpd (hdmi-hpd-fast) [116.711677] Subtest hdmi-hpd-fast: SKIP (0.000s) [117.621222] [096/171] (888s left) kms_chamelium_edid (hdmi-edid-read) [118.050263] Subtest hdmi-edid-read: SKIP (0.000s) [118.960925] [097/171] (886s left) kms_chamelium_frames (hdmi-crc-fast) [119.401368] Subtest hdmi-crc-fast: SKIP (0.000s) [120.305564] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast) [120.721214] Subtest vga-hpd-fast: SKIP (0.000s) [121.587777] [099/171] (884s left) kms_chamelium_edid (vga-edid-read) [122.004957] Subtest vga-edid-read: SKIP (0.000s) [122.866144] [100/171] (883s left) kms_prop_blob (basic) [122.962563] Starting subtest: basic [122.963553] Subtest basic: SUCCESS (0.000s) [123.026607] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [123.163906] Starting subtest: basic-busy-flip-before-cursor-atomic [123.165831] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [123.246890] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [123.370720] Starting subtest: basic-busy-flip-before-cursor-legacy [123.372773] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [123.457486] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [123.581892] Starting subtest: basic-flip-after-cursor-atomic [124.854855] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.271s) [125.785851] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [125.912818] Starting subtest: basic-flip-after-cursor-legacy [127.174956] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.261s) [128.087090] [105/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [128.218711] Starting subtest: basic-flip-after-cursor-varying-size [129.483976] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.264s) [130.392479] [106/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [130.523420] Starting subtest: basic-flip-before-cursor-atomic [131.793088] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.267s) [132.761386] [107/171] (873s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [132.892042] Starting subtest: basic-flip-before-cursor-legacy [134.151195] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.260s) [135.063055] [108/171] (871s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [135.189526] Starting subtest: basic-flip-before-cursor-varying-size [136.465563] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.273s) [137.370576] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [137.476959] Starting subtest: basic-flip-vs-dpms [137.481786] Starting dynamic subtest: A-eDP1 [140.301638] Dynamic subtest A-eDP1: SUCCESS (2.818s) [140.312998] Starting dynamic subtest: B-eDP1 [142.668441] Dynamic subtest B-eDP1: SUCCESS (2.365s) [142.680787] Starting dynamic subtest: C-eDP1 [145.031106] Dynamic subtest C-eDP1: SUCCESS (2.362s) [145.034188] Subtest basic-flip-vs-dpms: SUCCESS (7.558s) [145.944911] [110/171] (860s left) kms_flip (basic-flip-vs-modeset) [146.050195] Starting subtest: basic-flip-vs-modeset [146.054718] Starting dynamic subtest: A-eDP1 [148.880754] Dynamic subtest A-eDP1: SUCCESS (2.825s) [148.901508] Starting dynamic subtest: B-eDP1 [151.250727] Dynamic subtest B-eDP1: SUCCESS (2.364s) [151.267885] Starting dynamic subtest: C-eDP1 [153.608819] Dynamic subtest C-eDP1: SUCCESS (2.358s) [153.612689] Subtest basic-flip-vs-modeset: SUCCESS (7.563s) [154.523507] [111/171] (851s left) kms_flip (basic-flip-vs-wf_vblank) [154.629820] Starting subtest: basic-flip-vs-wf_vblank [154.635046] Starting dynamic subtest: A-eDP1 [156.919857] Dynamic subtest A-eDP1: SUCCESS (2.286s) [156.930125] Starting dynamic subtest: B-eDP1 [159.230209] Dynamic subtest B-eDP1: SUCCESS (2.303s) [159.241550] Starting dynamic subtest: C-eDP1 [161.526671] Dynamic subtest C-eDP1: SUCCESS (2.302s) [161.529911] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.902s) [162.843661] [112/171] (843s left) kms_flip (basic-plain-flip) [162.950899] Starting subtest: basic-plain-flip [162.953454] Starting dynamic subtest: A-eDP1 [164.960539] Dynamic subtest A-eDP1: SUCCESS (2.005s) [164.970593] Starting dynamic subtest: B-eDP1 [166.949289] Dynamic subtest B-eDP1: SUCCESS (1.981s) [166.974802] Starting dynamic subtest: C-eDP1 [168.993132] Dynamic subtest C-eDP1: SUCCESS (2.041s) [169.007420] Subtest basic-plain-flip: SUCCESS (6.058s) [170.333656] [113/171] (835s left) kms_force_connector_basic (force-connector-state) [170.452532] Starting subtest: force-connector-state [170.960564] Subtest force-connector-state: SUCCESS (0.507s) [172.110814] [114/171] (834s left) kms_force_connector_basic (force-edid) [172.226747] Starting subtest: force-edid [172.258350] Subtest force-edid: SUCCESS (0.031s) [172.401220] [115/171] (833s left) kms_force_connector_basic (force-load-detect) [172.516037] Starting subtest: force-load-detect [172.518065] Subtest force-load-detect: SKIP (0.000s) [172.659794] [116/171] (833s left) kms_force_connector_basic (prune-stale-modes) [172.769554] Starting subtest: prune-stale-modes [172.800588] Subtest prune-stale-modes: SUCCESS (0.033s) [172.949888] [117/171] (833s left) kms_frontbuffer_tracking (basic) [173.106166] Starting subtest: basic [175.926923] Subtest basic: SUCCESS (2.822s) [176.033308] [118/171] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [176.153743] Starting subtest: compare-crc-sanitycheck [176.154723] Starting dynamic subtest: pipe-A-eDP-1 [176.810045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s) [176.835084] Starting dynamic subtest: pipe-B-eDP-1 [178.161978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s) [178.171629] Starting dynamic subtest: pipe-C-eDP-1 [179.505534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.343s) [179.506564] Subtest compare-crc-sanitycheck: SUCCESS (3.351s) [180.431291] [119/171] (825s left) kms_pipe_crc_basic (hang-read-crc) [180.558062] Starting subtest: hang-read-crc [180.559019] Starting dynamic subtest: pipe-A-eDP-1 [182.787475] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.228s) [182.799032] Starting dynamic subtest: pipe-B-eDP-1 [185.741569] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.952s) [185.757955] Starting dynamic subtest: pipe-C-eDP-1 [188.695304] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.952s) [188.696394] Subtest hang-read-crc: SUCCESS (8.137s) [189.694863] [120/171] (816s left) kms_pipe_crc_basic (nonblocking-crc) [189.823660] Starting subtest: nonblocking-crc [189.824795] Starting dynamic subtest: pipe-A-eDP-1 [190.633935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s) [190.643153] Starting dynamic subtest: pipe-B-eDP-1 [192.200033] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [192.211444] Starting dynamic subtest: pipe-C-eDP-1 [193.750726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.548s) [193.751740] Subtest nonblocking-crc: SUCCESS (3.928s) [194.726749] [121/171] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.862224] Starting subtest: nonblocking-crc-frame-sequence [194.863248] Starting dynamic subtest: pipe-A-eDP-1 [195.682091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s) [195.699769] Starting dynamic subtest: pipe-B-eDP-1 [197.276802] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s) [197.293338] Starting dynamic subtest: pipe-C-eDP-1 [198.852258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.576s) [198.853370] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.990s) [199.773871] [122/171] (806s left) kms_pipe_crc_basic (read-crc) [199.908921] Starting subtest: read-crc [199.909915] Starting dynamic subtest: pipe-A-eDP-1 [200.661469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s) [200.672685] Starting dynamic subtest: pipe-B-eDP-1 [202.162258] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.498s) [202.181200] Starting dynamic subtest: pipe-C-eDP-1 [203.666640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s) [203.668077] Subtest read-crc: SUCCESS (3.757s) [204.629722] [123/171] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [204.760446] Starting subtest: read-crc-frame-sequence [204.761568] Starting dynamic subtest: pipe-A-eDP-1 [205.503416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [205.515948] Starting dynamic subtest: pipe-B-eDP-1 [206.997389] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.494s) [207.012538] Starting dynamic subtest: pipe-C-eDP-1 [208.516778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.518s) [208.517871] Subtest read-crc-frame-sequence: SUCCESS (3.758s) [209.433810] [124/171] (796s left) kms_psr (primary_page_flip) [209.568368] Starting subtest: primary_page_flip [211.556162] Subtest primary_page_flip: SUCCESS (1.985s) [212.502230] [125/171] (793s left) kms_psr (cursor_plane_move) [212.631704] Starting subtest: cursor_plane_move [214.602164] Subtest cursor_plane_move: SUCCESS (1.969s) [215.510756] [126/171] (790s left) kms_psr (sprite_plane_onoff) [215.641716] Starting subtest: sprite_plane_onoff [217.673616] Subtest sprite_plane_onoff: SUCCESS (2.034s) [218.591495] [127/171] (787s left) kms_psr (primary_mmap_gtt) [218.724689] Starting subtest: primary_mmap_gtt [220.748350] Subtest primary_mmap_gtt: SUCCESS (2.024s) [221.654841] [128/171] (784s left) kms_setmode (basic-clone-single-crtc) [221.750477] Starting subtest: basic-clone-single-crtc [221.753216] Subtest basic-clone-single-crtc: SKIP (0.001s) [221.826972] [129/171] (784s left) i915_pm_backlight (basic-brightness) [221.964241] Starting subtest: basic-brightness [222.067916] Starting dynamic subtest: eDP-1 [222.678934] Dynamic subtest eDP-1: SUCCESS (0.610s) [222.680127] Subtest basic-brightness: SUCCESS (0.713s) [223.641551] [130/171] (782s left) i915_pm_rpm (basic-pci-d3-state) [225.384183] Starting subtest: basic-pci-d3-state [229.995480] Subtest basic-pci-d3-state: SUCCESS (4.623s) [230.151291] [131/171] (776s left) i915_pm_rpm (basic-rte) [230.240631] Starting subtest: basic-rte [236.419438] Subtest basic-rte: SUCCESS (6.178s) [241.783543] [132/171] (764s left) i915_pm_rps (basic-api) [241.879349] Starting subtest: basic-api [241.884112] Subtest basic-api: SUCCESS (0.005s) [241.946915] [133/171] (764s left) prime_self_import (basic-llseek-bad) [242.038764] Starting subtest: basic-llseek-bad [242.039746] Subtest basic-llseek-bad: SUCCESS (0.002s) [242.179969] [134/171] (764s left) prime_self_import (basic-llseek-size) [242.268071] Starting subtest: basic-llseek-size [242.271863] Subtest basic-llseek-size: SUCCESS (0.003s) [242.392642] [135/171] (764s left) prime_self_import (basic-with_fd_dup) [242.492920] Starting subtest: basic-with_fd_dup [242.496229] Subtest basic-with_fd_dup: SUCCESS (0.003s) [242.629470] [136/171] (764s left) prime_self_import (basic-with_one_bo) [242.720934] Starting subtest: basic-with_one_bo [242.725192] Subtest basic-with_one_bo: SUCCESS (0.004s) [242.798274] [137/171] (763s left) prime_self_import (basic-with_one_bo_two_files) [242.888568] Starting subtest: basic-with_one_bo_two_files [242.891633] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [243.006141] [138/171] (763s left) prime_self_import (basic-with_two_bos) [243.106078] Starting subtest: basic-with_two_bos [243.109660] Subtest basic-with_two_bos: SUCCESS (0.003s) [243.237440] [139/171] (763s left) prime_vgem (basic-fence-flip) [243.367201] Starting subtest: basic-fence-flip [243.877064] Subtest basic-fence-flip: SUCCESS (0.509s) [244.003439] [140/171] (762s left) prime_vgem (basic-fence-mmap) [244.122240] Starting subtest: basic-fence-mmap [244.152571] Subtest basic-fence-mmap: SUCCESS (0.030s) [244.253300] [141/171] (762s left) prime_vgem (basic-fence-read) [244.390037] Starting subtest: basic-fence-read [244.442083] Subtest basic-fence-read: SUCCESS (0.052s) [244.510920] [142/171] (762s left) prime_vgem (basic-gtt) [244.626148] Starting subtest: basic-gtt [244.641323] Subtest basic-gtt: SUCCESS (0.015s) [244.727025] [143/171] (762s left) prime_vgem (basic-read) [244.852195] Starting subtest: basic-read [244.876384] Subtest basic-read: SUCCESS (0.024s) [244.964127] [144/171] (761s left) prime_vgem (basic-write) [245.073169] Starting subtest: basic-write [245.101041] Subtest basic-write: SUCCESS (0.028s) [245.177763] [145/171] (761s left) prime_vgem (basic-userptr) [245.288994] Starting subtest: basic-userptr [245.298390] Subtest basic-userptr: SKIP (0.009s) [245.435264] [146/171] (761s left) vgem_basic (setversion) [245.555795] Starting subtest: setversion [245.558019] Subtest setversion: SUCCESS (0.000s) [245.619746] [147/171] (761s left) vgem_basic (create) [245.722202] Starting subtest: create [245.723371] Subtest create: SUCCESS (0.000s) [245.779808] [148/171] (761s left) vgem_basic (debugfs) [245.872308] Starting subtest: debugfs [245.873417] Subtest debugfs: SUCCESS (0.001s) [245.930158] [149/171] (761s left) vgem_basic (dmabuf-export) [246.022144] Starting subtest: dmabuf-export [246.025309] Subtest dmabuf-export: SUCCESS (0.002s) [246.142781] [150/171] (760s left) vgem_basic (dmabuf-fence) [246.261167] Starting subtest: dmabuf-fence [246.262131] Subtest dmabuf-fence: SUCCESS (0.001s) [246.325145] [151/171] (760s left) vgem_basic (dmabuf-fence-before) [246.427583] Starting subtest: dmabuf-fence-before [246.428554] Subtest dmabuf-fence-before: SUCCESS (0.000s) [246.485572] [152/171] (760s left) vgem_basic (dmabuf-mmap) [246.577684] Starting subtest: dmabuf-mmap [246.596451] Subtest dmabuf-mmap: SUCCESS (0.019s) [246.651827] [153/171] (760s left) vgem_basic (mmap) [246.744244] Starting subtest: mmap [246.757393] Subtest mmap: SUCCESS (0.013s) [246.824941] [154/171] (760s left) vgem_basic (second-client) [246.927857] Starting subtest: second-client [246.977212] Subtest second-client: SUCCESS (0.049s) [247.046208] [155/171] (760s left) vgem_basic (sysfs) [247.183809] Starting subtest: sysfs [247.185196] Subtest sysfs: SUCCESS (0.001s) [247.271158] [156/171] (759s left) core_hotunplug (unbind-rebind) [247.402451] Starting subtest: unbind-rebind [249.564678] Subtest unbind-rebind: SUCCESS (2.162s) [249.626481] [157/171] (757s left) vgem_basic (unload) [249.783089] Starting subtest: unload [278.638325] Subtest unload: SUCCESS (28.820s) [278.704434] [158/171] (728s left) i915_module_load (reload) [278.795968] Starting subtest: reload [281.660596] Subtest reload: SUCCESS (2.864s) [281.690667] [159/171] (725s left) gem_lmem_swapping (basic) [281.903863] Subtest basic: SKIP (0.000s) [281.947961] [160/171] (725s left) gem_lmem_swapping (parallel-random-engines) [282.044860] Subtest parallel-random-engines: SKIP (0.000s) [282.081612] [161/171] (725s left) gem_lmem_swapping (random-engines) [282.179507] Subtest random-engines: SKIP (0.000s) [282.214599] [162/171] (725s left) gem_lmem_swapping (verify-random) [282.310686] Subtest verify-random: SKIP (0.000s) [282.347414] [163/171] (724s left) i915_pm_rpm (module-reload) [284.982878] Starting subtest: module-reload [300.827574] Subtest module-reload: SUCCESS (15.838s) [300.841339] [164/171] (706s left) i915_selftest (live) [300.942055] Starting subtest: live [300.943091] Starting dynamic subtest: sanitycheck [302.573533] Dynamic subtest sanitycheck: SUCCESS (1.622s) [302.585067] Starting dynamic subtest: uncore [304.156502] Dynamic subtest uncore: SUCCESS (1.582s) [304.164180] Starting dynamic subtest: workarounds [305.906485] Dynamic subtest workarounds: SUCCESS (1.749s) [305.913756] Starting dynamic subtest: gt_engines [307.932673] Dynamic subtest gt_engines: SUCCESS (2.025s) [307.944191] Starting dynamic subtest: gt_timelines [317.704756] Dynamic subtest gt_timelines: SUCCESS (9.771s) [317.716197] Starting dynamic subtest: gt_contexts [319.410455] Dynamic subtest gt_contexts: SUCCESS (1.705s) [319.418030] Starting dynamic subtest: gt_lrc [323.503577] Dynamic subtest gt_lrc: SUCCESS (4.092s) [323.511071] Starting dynamic subtest: gt_mocs [325.210462] Dynamic subtest gt_mocs: SUCCESS (1.706s) [325.221939] Starting dynamic subtest: gt_pm [331.146838] Dynamic subtest gt_pm: SUCCESS (5.935s) [331.154705] Starting dynamic subtest: gt_heartbeat [332.897738] Dynamic subtest gt_heartbeat: SUCCESS (1.750s) [332.905445] Starting dynamic subtest: requests [340.325917] Dynamic subtest requests: SUCCESS (7.427s) [340.333751] Starting dynamic subtest: migrate [344.753314] Dynamic subtest migrate: SUCCESS (4.427s) [344.760973] Starting dynamic subtest: active [346.407810] Dynamic subtest active: SUCCESS (1.654s) [346.415571] Starting dynamic subtest: objects [349.151342] Dynamic subtest objects: SUCCESS (2.743s) [349.158808] Starting dynamic subtest: mman [354.289617] Dynamic subtest mman: SUCCESS (5.137s) [354.301144] Starting dynamic subtest: dmabuf [355.889672] Dynamic subtest dmabuf: SUCCESS (1.599s) [355.897464] Starting dynamic subtest: vma [357.537568] Dynamic subtest vma: SUCCESS (1.647s) [357.545418] Starting dynamic subtest: coherency [360.391719] Dynamic subtest coherency: SUCCESS (2.853s) [360.399617] Starting dynamic subtest: gtt [370.724513] Dynamic subtest gtt: SUCCESS (10.332s) [370.736199] Starting dynamic subtest: gem [372.626868] Dynamic subtest gem: SUCCESS (1.903s) [372.638361] Starting dynamic subtest: evict [375.734503] Dynamic subtest evict: SUCCESS (3.105s) [375.746195] Starting dynamic subtest: hugepages [381.735822] Dynamic subtest hugepages: SUCCESS (6.000s) [381.743709] Starting dynamic subtest: gem_contexts [396.077428] Dynamic subtest gem_contexts: SUCCESS (14.341s) [396.089058] Starting dynamic subtest: client [397.739773] Dynamic subtest client: SUCCESS (1.662s) [397.751411] Starting dynamic subtest: gem_migrate [399.325854] Dynamic subtest gem_migrate: SUCCESS (1.585s) [399.337545] Starting dynamic subtest: reset [401.570614] Dynamic subtest reset: SUCCESS (2.244s) [401.578534] Starting dynamic subtest: memory_region [403.177543] Dynamic subtest memory_region: SUCCESS (1.606s) [403.185629] Starting dynamic subtest: hangcheck [427.249958] Dynamic subtest hangcheck: SUCCESS (24.072s) [427.257909] Starting dynamic subtest: execlists [436.663541] Dynamic subtest execlists: SUCCESS (9.413s) [436.671380] Starting dynamic subtest: ring_submission [438.238691] Dynamic subtest ring_submission: SUCCESS (1.574s) [438.246467] Starting dynamic subtest: perf [440.049726] Dynamic subtest perf: SUCCESS (1.810s) [440.057569] Starting dynamic subtest: slpc [441.638686] Dynamic subtest slpc: SUCCESS (1.588s) [441.646723] Starting dynamic subtest: guc [443.234727] Dynamic subtest guc: SUCCESS (1.595s) [443.242687] Starting dynamic subtest: guc_multi_lrc [444.849678] Dynamic subtest guc_multi_lrc: SUCCESS (1.614s) [444.857521] Starting dynamic subtest: guc_hang [446.465860] Dynamic subtest guc_hang: SUCCESS (1.615s) [446.477711] Starting dynamic subtest: late_gt_pm [448.168157] Dynamic subtest late_gt_pm: SUCCESS (1.701s) [448.169302] Subtest live: SUCCESS (147.217s) [448.235444] [165/171] (559s left) dmabuf (all-tests) [448.334242] Starting subtest: all-tests [448.335303] Starting dynamic subtest: sanitycheck [448.354499] Dynamic subtest sanitycheck: SUCCESS (0.019s) [448.363818] Starting dynamic subtest: dma_fence [448.485491] Dynamic subtest dma_fence: SUCCESS (0.130s) [448.494208] Starting dynamic subtest: dma_fence_chain [464.345982] Dynamic subtest dma_fence_chain: SUCCESS (15.851s) [464.354446] Starting dynamic subtest: dma_fence_unwrap [464.359428] Dynamic subtest dma_fence_unwrap: SUCCESS (0.021s) [464.367832] Starting dynamic subtest: dma_resv [464.391461] Dynamic subtest dma_resv: SUCCESS (0.031s) [464.392513] Subtest all-tests: SUCCESS (16.057s) [464.410088] [166/171] (542s left) i915_suspend (basic-s2idle-without-i915) [464.501736] Starting subtest: basic-s2idle-without-i915 [483.888154] Subtest basic-s2idle-without-i915: SUCCESS (3.857s) [486.244743] [167/171] (538s left) i915_suspend (basic-s3-without-i915) [486.340703] Starting subtest: basic-s3-without-i915 [506.869079] Subtest basic-s3-without-i915: SUCCESS (3.976s) [508.888340] [168/171] (534s left) gem_exec_suspend (basic-s0) [509.010649] Starting subtest: basic-S0 [509.011818] Starting dynamic subtest: smem [528.040259] Dynamic subtest smem: SUCCESS (3.257s) [528.041586] Subtest basic-S0: SUCCESS (3.258s) [530.334199] [169/171] (530s left) gem_exec_suspend (basic-s3) [530.484984] Starting subtest: basic-S3 [530.486111] Starting dynamic subtest: smem [550.782052] Dynamic subtest smem: SUCCESS (4.023s) [550.783011] Subtest basic-S3: SUCCESS (4.024s) [554.042734] [170/171] (526s left) kms_chamelium_hpd (common-hpd-after-suspend) [554.489442] Subtest common-hpd-after-suspend: SKIP (0.000s) [555.364551] [171/171] (525s left) kms_pipe_crc_basic (suspend-read-crc) [555.497575] Starting subtest: suspend-read-crc [555.498700] Starting dynamic subtest: pipe-A-eDP-1 [575.192444] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.550s) [575.206018] Starting dynamic subtest: pipe-B-eDP-1 [596.225842] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.359s) [596.239409] Starting dynamic subtest: pipe-C-eDP-1 [627.087262] Dynamic subtest pipe-C-eDP-1: SUCCESS (14.232s) [627.088280] Subtest suspend-read-crc: SUCCESS (22.144s) [628.960473] Closing watchdogs Done.