[40.810542] Initializing watchdogs [40.810662] /dev/watchdog0 [40.817665] [001/171] (960s left) i915_module_load (load) [40.924256] Starting subtest: load [41.946232] Subtest load: SUCCESS (1.022s) [41.983104] [002/171] (959s left) core_auth (basic-auth) [42.114922] Starting subtest: basic-auth [42.117351] Subtest basic-auth: SUCCESS (0.002s) [42.204710] [003/171] (959s left) debugfs_test (read_all_entries) [42.422177] Starting subtest: read_all_entries [42.520986] Subtest read_all_entries: SUCCESS (0.098s) [42.629711] [004/171] (958s left) debugfs_test (basic-hwmon) [42.732090] Starting subtest: basic-hwmon [42.733976] Subtest basic-hwmon: SKIP (0.000s) [42.846627] [005/171] (958s left) fbdev (eof) [42.974132] Starting subtest: eof [42.975188] Subtest eof: SUCCESS (0.001s) [43.027517] [006/171] (958s left) fbdev (info) [43.120025] Starting subtest: info [43.121030] Subtest info: SUCCESS (0.000s) [43.179598] [007/171] (958s left) fbdev (nullptr) [43.290551] Starting subtest: nullptr [43.291568] Subtest nullptr: SUCCESS (0.000s) [43.344137] [008/171] (958s left) fbdev (read) [43.440776] Starting subtest: read [44.288638] Subtest read: SUCCESS (0.839s) [44.329640] [009/171] (957s left) fbdev (write) [44.441152] Starting subtest: write [44.864345] Subtest write: SUCCESS (0.415s) [44.954140] [010/171] (956s left) gem_basic (bad-close) [45.052719] Starting subtest: bad-close [45.054578] Subtest bad-close: SUCCESS (0.000s) [45.188153] [011/171] (956s left) gem_basic (create-close) [45.290936] Starting subtest: create-close [45.292926] Subtest create-close: SUCCESS (0.000s) [45.404908] [012/171] (956s left) gem_basic (create-fd-close) [45.532296] Starting subtest: create-fd-close [45.537586] Subtest create-fd-close: SUCCESS (0.000s) [45.660474] [013/171] (955s left) gem_busy (busy@all-engines) [45.786155] Starting subtest: busy [45.787064] Starting dynamic subtest: all-engines [45.843762] Dynamic subtest all-engines: SUCCESS (0.057s) [45.844677] Subtest busy: SUCCESS (0.058s) [46.269806] [014/171] (955s left) gem_close_race (basic-process) [46.388862] Starting subtest: basic-process [46.454422] Subtest basic-process: SUCCESS (0.066s) [46.663045] [015/171] (954s left) gem_close_race (basic-threads) [46.781822] Starting subtest: basic-threads [47.938678] Subtest basic-threads: SUCCESS (1.157s) [48.214768] [016/171] (953s left) gem_ctx_create (basic) [48.344507] Starting subtest: basic [48.345556] Subtest basic: SUCCESS (0.000s) [48.546439] [017/171] (953s left) gem_ctx_create (basic-files) [48.660856] Starting subtest: basic-files [50.684287] Subtest basic-files: SUCCESS (2.023s) [50.966978] [018/171] (950s left) gem_ctx_exec (basic) [51.096262] Starting subtest: basic [51.100675] Subtest basic: SUCCESS (0.004s) [51.216991] [019/171] (950s left) gem_exec_basic (basic) [51.333783] Starting subtest: basic [51.335082] Starting dynamic subtest: rcs0-smem [51.337085] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [51.344926] Starting dynamic subtest: bcs0-smem [51.345815] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [51.352692] Starting dynamic subtest: vcs0-smem [51.353910] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [51.360792] Starting dynamic subtest: vecs0-smem [51.362062] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [51.363178] Subtest basic: SUCCESS (0.007s) [51.573759] [020/171] (950s left) gem_exec_create (basic) [51.694074] Starting subtest: basic [51.695107] Starting dynamic subtest: smem [53.738467] Dynamic subtest smem: SUCCESS (2.045s) [53.739437] Subtest basic: SUCCESS (2.045s) [53.962713] [021/171] (947s left) gem_exec_fence (basic-busy) [54.246821] Starting subtest: basic-busy [54.248454] Starting dynamic subtest: rcs0 [54.274186] Dynamic subtest rcs0: SUCCESS (0.028s) [54.282150] Starting dynamic subtest: bcs0 [54.300339] Dynamic subtest bcs0: SUCCESS (0.026s) [54.307845] Starting dynamic subtest: vcs0 [54.321378] Dynamic subtest vcs0: SUCCESS (0.021s) [54.328903] Starting dynamic subtest: vecs0 [54.339238] Dynamic subtest vecs0: SUCCESS (0.018s) [54.340193] Subtest basic-busy: SUCCESS (0.093s) [55.042070] [022/171] (946s left) gem_exec_fence (basic-wait) [55.314241] Starting subtest: basic-wait [55.316111] Starting dynamic subtest: rcs0 [55.336592] Dynamic subtest rcs0: SUCCESS (0.022s) [55.346377] Starting dynamic subtest: bcs0 [55.363383] Dynamic subtest bcs0: SUCCESS (0.027s) [55.371297] Starting dynamic subtest: vcs0 [55.390353] Dynamic subtest vcs0: SUCCESS (0.027s) [55.398253] Starting dynamic subtest: vecs0 [55.408206] Dynamic subtest vecs0: SUCCESS (0.018s) [55.409251] Subtest basic-wait: SUCCESS (0.095s) [56.042828] [023/171] (945s left) gem_exec_fence (basic-await) [56.318328] Starting subtest: basic-await [56.319631] Starting dynamic subtest: rcs0 [56.418275] Dynamic subtest rcs0: SUCCESS (0.100s) [56.428060] Starting dynamic subtest: bcs0 [56.516134] Dynamic subtest bcs0: SUCCESS (0.098s) [56.525532] Starting dynamic subtest: vcs0 [56.614107] Dynamic subtest vcs0: SUCCESS (0.097s) [56.624418] Starting dynamic subtest: vecs0 [56.717357] Dynamic subtest vecs0: SUCCESS (0.103s) [56.718407] Subtest basic-await: SUCCESS (0.399s) [57.497556] [024/171] (944s left) gem_exec_fence (nb-await) [57.759315] Starting subtest: nb-await [57.761464] Starting dynamic subtest: rcs0 [57.834837] Dynamic subtest rcs0: SUCCESS (0.074s) [57.864947] Starting dynamic subtest: bcs0 [57.927626] Dynamic subtest bcs0: SUCCESS (0.088s) [57.976475] Starting dynamic subtest: vcs0 [58.043939] Dynamic subtest vcs0: SUCCESS (0.114s) [58.088289] Starting dynamic subtest: vecs0 [58.151844] Dynamic subtest vecs0: SUCCESS (0.109s) [58.155784] Subtest nb-await: SUCCESS (0.390s) [58.886720] [025/171] (943s left) gem_exec_gttfill (basic) [59.012385] Starting subtest: basic [68.410068] Subtest basic: SUCCESS (9.389s) [68.600593] [026/171] (933s left) gem_exec_parallel (engines) [68.772371] Starting subtest: engines [68.773540] Starting dynamic subtest: basic [71.145347] Dynamic subtest basic: SUCCESS (2.372s) [71.163888] Starting dynamic subtest: contexts [74.178945] Dynamic subtest contexts: SUCCESS (3.026s) [74.189182] Starting dynamic subtest: fds [77.253747] Dynamic subtest fds: SUCCESS (3.083s) [77.263152] Starting dynamic subtest: userptr [79.572177] Dynamic subtest userptr: SUCCESS (2.318s) [79.573957] Subtest engines: SUCCESS (10.800s) [79.807943] [027/171] (922s left) gem_exec_store (basic) [79.942214] Starting subtest: basic [79.993508] Subtest basic: SUCCESS (0.051s) [80.222607] [028/171] (921s left) gem_flink_basic (bad-flink) [80.334099] Starting subtest: bad-flink [80.335257] Subtest bad-flink: SUCCESS (0.000s) [80.424339] [029/171] (921s left) gem_flink_basic (bad-open) [80.532047] Starting subtest: bad-open [80.533057] Subtest bad-open: SUCCESS (0.000s) [80.631869] [030/171] (921s left) gem_flink_basic (basic) [80.742594] Starting subtest: basic [80.743892] Subtest basic: SUCCESS (0.000s) [80.846998] [031/171] (921s left) gem_flink_basic (double-flink) [80.959119] Starting subtest: double-flink [80.960204] Subtest double-flink: SUCCESS (0.000s) [81.061952] [032/171] (921s left) gem_flink_basic (flink-lifetime) [81.169289] Starting subtest: flink-lifetime [81.170364] Subtest flink-lifetime: SUCCESS (0.001s) [81.269684] [033/171] (920s left) gem_huc_copy (huc-copy) [81.384793] Starting subtest: huc-copy [81.386895] Subtest huc-copy: SKIP (0.000s) [81.531919] [034/171] (920s left) gem_linear_blits (basic) [81.789273] Starting subtest: basic [81.799937] Subtest basic: SUCCESS (0.011s) [81.949737] [035/171] (920s left) gem_mmap (basic) [82.112120] Starting subtest: basic [82.116611] Subtest basic: SUCCESS (0.001s) [82.198482] [036/171] (919s left) gem_mmap_gtt (basic) [82.306353] Starting subtest: basic [82.307290] Subtest basic: SUCCESS (0.001s) [82.404829] [037/171] (919s left) gem_render_linear_blits (basic) [82.520910] Starting subtest: basic [82.562261] Subtest basic: SUCCESS (0.041s) [82.603097] [038/171] (919s left) gem_render_tiled_blits (basic) [82.718124] Starting subtest: basic [82.777748] Subtest basic: SUCCESS (0.058s) [82.836458] [039/171] (919s left) gem_ringfill (basic-all) [83.144306] Starting subtest: basic-all [84.317016] Subtest basic-all: SUCCESS (1.164s) [84.406124] [040/171] (917s left) gem_softpin (allocator-basic) [84.522838] Starting subtest: allocator-basic [84.659556] Subtest allocator-basic: SUCCESS (0.128s) [84.773023] [041/171] (917s left) gem_softpin (allocator-basic-reserve) [84.893770] Starting subtest: allocator-basic-reserve [85.032304] Subtest allocator-basic-reserve: SUCCESS (0.130s) [85.166248] [042/171] (917s left) gem_softpin (safe-alignment) [85.284373] Starting subtest: safe-alignment [85.300070] Subtest safe-alignment: SUCCESS (0.016s) [85.443056] [043/171] (916s left) gem_sync (basic-all) [85.568154] Starting subtest: basic-all [87.811426] Subtest basic-all: SUCCESS (2.243s) [88.033372] [044/171] (914s left) gem_sync (basic-each) [88.184346] Starting subtest: basic-each [90.394497] Subtest basic-each: SUCCESS (2.210s) [90.664656] [045/171] (911s left) gem_tiled_blits (basic) [90.947655] Starting subtest: basic [90.972755] Subtest basic: SUCCESS (0.025s) [91.127224] [046/171] (911s left) gem_tiled_fence_blits (basic) [91.443090] Starting subtest: basic [91.456467] Subtest basic: SUCCESS (0.013s) [91.616191] [047/171] (910s left) gem_tiled_pread_basic [92.004480] [048/171] (910s left) gem_wait (busy@all-engines) [92.136242] Starting subtest: busy [92.137255] Starting dynamic subtest: all-engines [92.674618] Dynamic subtest all-engines: SUCCESS (0.539s) [92.675952] Subtest busy: SUCCESS (0.539s) [92.911670] [049/171] (909s left) gem_wait (wait@all-engines) [93.055190] Starting subtest: wait [93.056157] Starting dynamic subtest: all-engines [94.116794] Dynamic subtest all-engines: SUCCESS (1.059s) [94.120220] Subtest wait: SUCCESS (1.060s) [94.400583] [050/171] (908s left) i915_getparams_basic (basic-eu-total) [94.509014] Starting subtest: basic-eu-total [94.510806] Subtest basic-eu-total: SUCCESS (0.000s) [94.600904] [051/171] (907s left) i915_getparams_basic (basic-subslice-total) [94.709275] Starting subtest: basic-subslice-total [94.711178] Subtest basic-subslice-total: SUCCESS (0.000s) [94.805610] [052/171] (907s left) i915_hangman (error-state-basic) [94.926505] Starting subtest: error-state-basic [94.937697] Subtest error-state-basic: SUCCESS (0.010s) [95.030274] [053/171] (907s left) i915_pciid [95.230799] [054/171] (907s left) kms_addfb_basic (addfb25-bad-modifier) [95.342738] Starting subtest: addfb25-bad-modifier [95.343864] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.506466] [055/171] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.615573] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.616626] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.750835] [056/171] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.857199] Starting subtest: addfb25-modifier-no-flag [95.858246] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [95.999138] [057/171] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.107438] Starting subtest: addfb25-x-tiled-legacy [96.108349] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.250917] [058/171] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.358472] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.359491] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [96.494639] [059/171] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [96.634470] Starting subtest: addfb25-yf-tiled-legacy [96.635448] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.738524] [060/171] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.874013] Starting subtest: addfb25-y-tiled-legacy [96.875031] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.970315] [061/171] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.111061] Starting subtest: addfb25-y-tiled-small-legacy [97.112082] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [97.211017] [062/171] (905s left) kms_addfb_basic (bad-pitch-0) [97.308335] Starting subtest: bad-pitch-0 [97.309316] Subtest bad-pitch-0: SUCCESS (0.000s) [97.430101] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024) [97.529654] Starting subtest: bad-pitch-1024 [97.530733] Subtest bad-pitch-1024: SUCCESS (0.000s) [97.663186] [064/171] (905s left) kms_addfb_basic (bad-pitch-128) [97.761911] Starting subtest: bad-pitch-128 [97.762990] Subtest bad-pitch-128: SUCCESS (0.000s) [97.886991] [065/171] (904s left) kms_addfb_basic (bad-pitch-256) [97.982375] Starting subtest: bad-pitch-256 [97.983293] Subtest bad-pitch-256: SUCCESS (0.000s) [98.125169] [066/171] (904s left) kms_addfb_basic (bad-pitch-32) [98.223207] Starting subtest: bad-pitch-32 [98.224195] Subtest bad-pitch-32: SUCCESS (0.000s) [98.356971] [067/171] (904s left) kms_addfb_basic (bad-pitch-63) [98.455677] Starting subtest: bad-pitch-63 [98.456708] Subtest bad-pitch-63: SUCCESS (0.000s) [98.596070] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536) [98.693616] Starting subtest: bad-pitch-65536 [98.694838] Subtest bad-pitch-65536: SUCCESS (0.000s) [98.825602] [069/171] (904s left) kms_addfb_basic (bad-pitch-999) [98.922908] Starting subtest: bad-pitch-999 [98.923993] Subtest bad-pitch-999: SUCCESS (0.000s) [99.071258] [070/171] (903s left) kms_addfb_basic (basic) [99.168433] Starting subtest: basic [99.169423] Subtest basic: SUCCESS (0.000s) [99.292460] [071/171] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [99.389205] Starting subtest: basic-x-tiled-legacy [99.390190] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [99.527648] [072/171] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [99.626673] Starting subtest: basic-y-tiled-legacy [99.627695] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [99.754087] [073/171] (903s left) kms_addfb_basic (bo-too-small) [99.884659] Starting subtest: bo-too-small [99.885772] Subtest bo-too-small: SUCCESS (0.000s) [99.984340] [074/171] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [100.117942] Starting subtest: bo-too-small-due-to-tiling [100.118926] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [100.224131] [075/171] (902s left) kms_addfb_basic (clobberred-modifier) [100.319574] Starting subtest: clobberred-modifier [100.320665] Subtest clobberred-modifier: SUCCESS (0.000s) [100.462478] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [100.559604] Starting subtest: framebuffer-vs-set-tiling [100.563336] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.696062] [077/171] (902s left) kms_addfb_basic (invalid-get-prop) [100.793440] Starting subtest: invalid-get-prop [100.794439] Subtest invalid-get-prop: SUCCESS (0.000s) [100.937318] [078/171] (902s left) kms_addfb_basic (invalid-get-prop-any) [101.033343] Starting subtest: invalid-get-prop-any [101.034231] Subtest invalid-get-prop-any: SUCCESS (0.000s) [101.179489] [079/171] (901s left) kms_addfb_basic (invalid-set-prop) [101.276327] Starting subtest: invalid-set-prop [101.277463] Subtest invalid-set-prop: SUCCESS (0.000s) [101.406316] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any) [101.503208] Starting subtest: invalid-set-prop-any [101.504178] Subtest invalid-set-prop-any: SUCCESS (0.000s) [101.637030] [081/171] (901s left) kms_addfb_basic (no-handle) [101.735224] Starting subtest: no-handle [101.736207] Subtest no-handle: SUCCESS (0.000s) [101.863994] [082/171] (901s left) kms_addfb_basic (size-max) [101.993573] Starting subtest: size-max [101.994559] Subtest size-max: SUCCESS (0.000s) [102.094179] [083/171] (901s left) kms_addfb_basic (small-bo) [102.224938] Starting subtest: small-bo [102.226040] Subtest small-bo: SUCCESS (0.000s) [102.325102] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch) [102.423329] Starting subtest: tile-pitch-mismatch [102.424418] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [102.551843] [085/171] (900s left) kms_addfb_basic (too-high) [102.681882] Starting subtest: too-high [102.683042] Subtest too-high: SUCCESS (0.001s) [102.789519] [086/171] (900s left) kms_addfb_basic (too-wide) [102.923106] Starting subtest: too-wide [102.924067] Subtest too-wide: SUCCESS (0.000s) [103.024042] [087/171] (900s left) kms_addfb_basic (unused-handle) [103.125828] Starting subtest: unused-handle [103.126988] Subtest unused-handle: SUCCESS (0.000s) [103.262486] [088/171] (899s left) kms_addfb_basic (unused-modifier) [103.359346] Starting subtest: unused-modifier [103.360230] Subtest unused-modifier: SUCCESS (0.000s) [103.491270] [089/171] (899s left) kms_addfb_basic (unused-offsets) [103.588614] Starting subtest: unused-offsets [103.589664] Subtest unused-offsets: SUCCESS (0.000s) [103.730794] [090/171] (899s left) kms_addfb_basic (unused-pitches) [103.825482] Starting subtest: unused-pitches [103.826447] Subtest unused-pitches: SUCCESS (0.000s) [103.966384] [091/171] (899s left) kms_busy (basic) [104.105450] Starting subtest: basic [104.107527] Starting dynamic subtest: flip [105.145274] Dynamic subtest flip: SUCCESS (1.036s) [105.164896] Starting dynamic subtest: modeset [108.988125] Dynamic subtest modeset: SUCCESS (3.841s) [108.989827] Subtest basic: SUCCESS (4.880s) [109.888454] [092/171] (893s left) kms_chamelium_hpd (dp-hpd-fast) [110.337211] Subtest dp-hpd-fast: SKIP (0.000s) [111.249054] [093/171] (892s left) kms_chamelium_edid (dp-edid-read) [111.694712] Subtest dp-edid-read: SKIP (0.000s) [112.596653] [094/171] (890s left) kms_chamelium_frames (dp-crc-fast) [113.048899] Subtest dp-crc-fast: SKIP (0.000s) [113.941572] [095/171] (889s left) kms_chamelium_hpd (hdmi-hpd-fast) [114.386023] Subtest hdmi-hpd-fast: SKIP (0.000s) [115.278289] [096/171] (888s left) kms_chamelium_edid (hdmi-edid-read) [115.731857] Subtest hdmi-edid-read: SKIP (0.000s) [116.625599] [097/171] (886s left) kms_chamelium_frames (hdmi-crc-fast) [117.081503] Subtest hdmi-crc-fast: SKIP (0.000s) [117.967525] [098/171] (885s left) kms_chamelium_hpd (vga-hpd-fast) [118.426302] Subtest vga-hpd-fast: SKIP (0.000s) [119.317618] [099/171] (884s left) kms_chamelium_edid (vga-edid-read) [119.765362] Subtest vga-edid-read: SKIP (0.000s) [120.656543] [100/171] (882s left) kms_prop_blob (basic) [120.768118] Starting subtest: basic [120.769194] Subtest basic: SUCCESS (0.000s) [120.836272] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [120.987320] Starting subtest: basic-busy-flip-before-cursor-atomic [120.989329] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [121.071113] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [121.223518] Starting subtest: basic-busy-flip-before-cursor-legacy [121.225570] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [121.306888] [103/171] (882s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [121.451381] Starting subtest: basic-flip-after-cursor-atomic [122.793930] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.342s) [123.676258] [104/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [123.823869] Starting subtest: basic-flip-after-cursor-legacy [125.081788] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.253s) [126.017116] [105/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [126.167503] Starting subtest: basic-flip-after-cursor-varying-size [127.450644] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.281s) [128.394053] [106/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [128.541530] Starting subtest: basic-flip-before-cursor-atomic [129.878732] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.333s) [130.815919] [107/171] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [130.964527] Starting subtest: basic-flip-before-cursor-legacy [132.227357] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.262s) [133.180048] [108/171] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [133.326300] Starting subtest: basic-flip-before-cursor-varying-size [134.671185] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.342s) [135.616649] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [135.740417] Starting subtest: basic-flip-vs-dpms [135.743500] Starting dynamic subtest: A-eDP1 [138.621085] Dynamic subtest A-eDP1: SUCCESS (2.876s) [138.638372] Starting dynamic subtest: B-eDP1 [140.977198] Dynamic subtest B-eDP1: SUCCESS (2.355s) [140.987789] Starting dynamic subtest: C-eDP1 [143.341219] Dynamic subtest C-eDP1: SUCCESS (2.361s) [143.346330] Subtest basic-flip-vs-dpms: SUCCESS (7.606s) [144.246110] [110/171] (859s left) kms_flip (basic-flip-vs-modeset) [144.371900] Starting subtest: basic-flip-vs-modeset [144.374792] Starting dynamic subtest: A-eDP1 [147.185070] Dynamic subtest A-eDP1: SUCCESS (2.802s) [147.204266] Starting dynamic subtest: B-eDP1 [149.550103] Dynamic subtest B-eDP1: SUCCESS (2.366s) [149.561038] Starting dynamic subtest: C-eDP1 [151.913055] Dynamic subtest C-eDP1: SUCCESS (2.363s) [151.916180] Subtest basic-flip-vs-modeset: SUCCESS (7.546s) [152.829098] [111/171] (850s left) kms_flip (basic-flip-vs-wf_vblank) [152.953292] Starting subtest: basic-flip-vs-wf_vblank [152.958687] Starting dynamic subtest: A-eDP1 [155.289619] Dynamic subtest A-eDP1: SUCCESS (2.330s) [155.300737] Starting dynamic subtest: B-eDP1 [157.591077] Dynamic subtest B-eDP1: SUCCESS (2.299s) [157.604331] Starting dynamic subtest: C-eDP1 [159.895374] Dynamic subtest C-eDP1: SUCCESS (2.304s) [159.899495] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.947s) [161.218934] [112/171] (842s left) kms_flip (basic-plain-flip) [161.344157] Starting subtest: basic-plain-flip [161.349490] Starting dynamic subtest: A-eDP1 [163.398812] Dynamic subtest A-eDP1: SUCCESS (2.037s) [163.418163] Starting dynamic subtest: B-eDP1 [165.452403] Dynamic subtest B-eDP1: SUCCESS (2.043s) [165.472740] Starting dynamic subtest: C-eDP1 [167.490495] Dynamic subtest C-eDP1: SUCCESS (2.034s) [167.507539] Subtest basic-plain-flip: SUCCESS (6.164s) [168.829732] [113/171] (834s left) kms_force_connector_basic (force-connector-state) [168.965671] Starting subtest: force-connector-state [169.574724] Subtest force-connector-state: SUCCESS (0.611s) [170.621489] [114/171] (833s left) kms_force_connector_basic (force-edid) [170.751755] Starting subtest: force-edid [170.782247] Subtest force-edid: SUCCESS (0.033s) [170.943544] [115/171] (832s left) kms_force_connector_basic (force-load-detect) [171.068525] Starting subtest: force-load-detect [171.070474] Subtest force-load-detect: SKIP (0.000s) [171.216542] [116/171] (832s left) kms_force_connector_basic (prune-stale-modes) [171.345947] Starting subtest: prune-stale-modes [171.376374] Subtest prune-stale-modes: SUCCESS (0.032s) [171.532898] [117/171] (832s left) kms_frontbuffer_tracking (basic) [171.676664] Starting subtest: basic [174.513821] Subtest basic: SUCCESS (2.839s) [174.628157] [118/171] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [174.767477] Starting subtest: compare-crc-sanitycheck-xr24 [174.769117] Starting dynamic subtest: pipe-A-eDP-1 [175.405452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s) [175.416714] Starting dynamic subtest: pipe-B-eDP-1 [176.719988] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s) [176.732861] Starting dynamic subtest: pipe-C-eDP-1 [178.047294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s) [178.048235] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.275s) [178.975694] [119/171] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [179.109082] Starting subtest: compare-crc-sanitycheck-nv12 [179.110103] Starting dynamic subtest: pipe-A-eDP-1 [179.112011] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [179.125024] Starting dynamic subtest: pipe-B-eDP-1 [179.126926] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [179.138096] Starting dynamic subtest: pipe-C-eDP-1 [179.139955] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [179.141852] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s) [179.203434] [120/171] (824s left) kms_pipe_crc_basic (hang-read-crc) [179.338114] Starting subtest: hang-read-crc [179.339211] Starting dynamic subtest: pipe-A-eDP-1 [181.542546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.199s) [181.564129] Starting dynamic subtest: pipe-B-eDP-1 [184.453078] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.908s) [184.468992] Starting dynamic subtest: pipe-C-eDP-1 [187.388334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.931s) [187.389521] Subtest hang-read-crc: SUCCESS (8.051s) [188.340340] [121/171] (815s left) kms_pipe_crc_basic (nonblocking-crc) [188.489648] Starting subtest: nonblocking-crc [188.490763] Starting dynamic subtest: pipe-A-eDP-1 [189.316435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s) [189.332681] Starting dynamic subtest: pipe-B-eDP-1 [190.860393] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.541s) [190.873470] Starting dynamic subtest: pipe-C-eDP-1 [192.386157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s) [192.388288] Subtest nonblocking-crc: SUCCESS (3.896s) [193.338145] [122/171] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [193.483429] Starting subtest: nonblocking-crc-frame-sequence [193.484461] Starting dynamic subtest: pipe-A-eDP-1 [194.275145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s) [194.290836] Starting dynamic subtest: pipe-B-eDP-1 [195.804138] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s) [195.817517] Starting dynamic subtest: pipe-C-eDP-1 [197.367765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s) [197.369553] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.884s) [198.268377] [123/171] (805s left) kms_pipe_crc_basic (read-crc) [198.416529] Starting subtest: read-crc [198.417579] Starting dynamic subtest: pipe-A-eDP-1 [199.164674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s) [199.184169] Starting dynamic subtest: pipe-B-eDP-1 [200.643928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s) [200.659698] Starting dynamic subtest: pipe-C-eDP-1 [202.073130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.423s) [202.074184] Subtest read-crc: SUCCESS (3.658s) [203.014473] [124/171] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [203.160312] Starting subtest: read-crc-frame-sequence [203.163829] Starting dynamic subtest: pipe-A-eDP-1 [203.887088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s) [203.899534] Starting dynamic subtest: pipe-B-eDP-1 [205.354944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s) [205.366704] Starting dynamic subtest: pipe-C-eDP-1 [206.834070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [206.835203] Subtest read-crc-frame-sequence: SUCCESS (3.675s) [207.738627] [125/171] (796s left) kms_psr (primary_page_flip) [207.891303] Starting subtest: primary_page_flip [209.885351] Subtest primary_page_flip: SUCCESS (1.993s) [210.811985] [126/171] (793s left) kms_psr (cursor_plane_move) [210.961266] Starting subtest: cursor_plane_move [212.887964] Subtest cursor_plane_move: SUCCESS (1.925s) [213.768743] [127/171] (790s left) kms_psr (sprite_plane_onoff) [213.920576] Starting subtest: sprite_plane_onoff [215.917394] Subtest sprite_plane_onoff: SUCCESS (1.995s) [216.829691] [128/171] (787s left) kms_psr (primary_mmap_gtt) [216.977655] Starting subtest: primary_mmap_gtt [218.917722] Subtest primary_mmap_gtt: SUCCESS (1.937s) [219.836784] [129/171] (784s left) kms_setmode (basic-clone-single-crtc) [219.945851] Starting subtest: basic-clone-single-crtc [219.948562] Subtest basic-clone-single-crtc: SKIP (0.001s) [220.053641] [130/171] (784s left) i915_pm_backlight (basic-brightness) [220.213593] Starting subtest: basic-brightness [220.329263] Starting dynamic subtest: eDP-1 [220.936021] Dynamic subtest eDP-1: SUCCESS (0.607s) [220.937168] Subtest basic-brightness: SUCCESS (0.725s) [221.887272] [131/171] (782s left) i915_pm_rpm (basic-pci-d3-state) [223.650251] Starting subtest: basic-pci-d3-state [228.131524] Subtest basic-pci-d3-state: SUCCESS (4.482s) [228.290887] [132/171] (775s left) i915_pm_rpm (basic-rte) [228.400207] Starting subtest: basic-rte [234.595338] Subtest basic-rte: SUCCESS (6.193s) [239.970306] [133/171] (764s left) i915_pm_rps (basic-api) [240.087165] Starting subtest: basic-api [240.092404] Subtest basic-api: SUCCESS (0.005s) [240.229450] [134/171] (764s left) prime_self_import (basic-llseek-bad) [240.335324] Starting subtest: basic-llseek-bad [240.337434] Subtest basic-llseek-bad: SUCCESS (0.002s) [240.465953] [135/171] (763s left) prime_self_import (basic-llseek-size) [240.571354] Starting subtest: basic-llseek-size [240.576148] Subtest basic-llseek-size: SUCCESS (0.004s) [240.687192] [136/171] (763s left) prime_self_import (basic-with_fd_dup) [240.791776] Starting subtest: basic-with_fd_dup [240.795807] Subtest basic-with_fd_dup: SUCCESS (0.004s) [240.932390] [137/171] (763s left) prime_self_import (basic-with_one_bo) [241.038212] Starting subtest: basic-with_one_bo [241.042843] Subtest basic-with_one_bo: SUCCESS (0.004s) [241.115328] [138/171] (763s left) prime_self_import (basic-with_one_bo_two_files) [241.223516] Starting subtest: basic-with_one_bo_two_files [241.228407] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [241.334334] [139/171] (763s left) prime_self_import (basic-with_two_bos) [241.446309] Starting subtest: basic-with_two_bos [241.451065] Subtest basic-with_two_bos: SUCCESS (0.003s) [241.580909] [140/171] (762s left) prime_vgem (basic-fence-flip) [241.718084] Starting subtest: basic-fence-flip [242.210145] Subtest basic-fence-flip: SUCCESS (0.492s) [242.320391] [141/171] (762s left) prime_vgem (basic-fence-mmap) [242.434223] Starting subtest: basic-fence-mmap [242.471030] Subtest basic-fence-mmap: SUCCESS (0.037s) [242.564159] [142/171] (761s left) prime_vgem (basic-fence-read) [242.708524] Starting subtest: basic-fence-read [242.766448] Subtest basic-fence-read: SUCCESS (0.058s) [242.851499] [143/171] (761s left) prime_vgem (basic-gtt) [242.996864] Starting subtest: basic-gtt [243.012516] Subtest basic-gtt: SUCCESS (0.016s) [243.105656] [144/171] (761s left) prime_vgem (basic-read) [243.250292] Starting subtest: basic-read [243.276203] Subtest basic-read: SUCCESS (0.026s) [243.357196] [145/171] (761s left) prime_vgem (basic-write) [243.506701] Starting subtest: basic-write [243.537965] Subtest basic-write: SUCCESS (0.031s) [243.610168] [146/171] (760s left) vgem_basic (setversion) [243.755337] Starting subtest: setversion [243.757438] Subtest setversion: SUCCESS (0.000s) [243.817929] [147/171] (760s left) vgem_basic (create) [243.960461] Starting subtest: create [243.961629] Subtest create: SUCCESS (0.000s) [244.026928] [148/171] (760s left) vgem_basic (debugfs) [244.166107] Starting subtest: debugfs [244.167080] Subtest debugfs: SUCCESS (0.001s) [244.228825] [149/171] (760s left) vgem_basic (dmabuf-export) [244.371317] Starting subtest: dmabuf-export [244.373521] Subtest dmabuf-export: SUCCESS (0.002s) [244.494767] [150/171] (760s left) vgem_basic (dmabuf-fence) [244.625563] Starting subtest: dmabuf-fence [244.626712] Subtest dmabuf-fence: SUCCESS (0.001s) [244.689092] [151/171] (760s left) vgem_basic (dmabuf-fence-before) [244.831333] Starting subtest: dmabuf-fence-before [244.832453] Subtest dmabuf-fence-before: SUCCESS (0.000s) [244.905679] [152/171] (759s left) vgem_basic (dmabuf-mmap) [245.036605] Starting subtest: dmabuf-mmap [245.055170] Subtest dmabuf-mmap: SUCCESS (0.019s) [245.113679] [153/171] (759s left) vgem_basic (mmap) [245.258747] Starting subtest: mmap [245.272722] Subtest mmap: SUCCESS (0.014s) [245.340881] [154/171] (759s left) vgem_basic (second-client) [245.483809] Starting subtest: second-client [245.516598] Subtest second-client: SUCCESS (0.032s) [245.575761] [155/171] (759s left) vgem_basic (sysfs) [245.722544] Starting subtest: sysfs [245.723590] Subtest sysfs: SUCCESS (0.001s) [245.781500] [156/171] (759s left) core_hotunplug (unbind-rebind) [245.946401] Starting subtest: unbind-rebind [248.216676] Subtest unbind-rebind: SUCCESS (2.259s) [248.265703] [157/171] (756s left) vgem_basic (unload) [248.446521] Starting subtest: unload [277.554901] Subtest unload: SUCCESS (29.072s) [277.666578] [158/171] (727s left) i915_module_load (reload) [277.783784] Starting subtest: reload [281.163169] Subtest reload: SUCCESS (3.380s) [281.194366] [159/171] (723s left) gem_lmem_swapping (basic) [281.408919] Subtest basic: SKIP (0.000s) [281.463546] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines) [281.575371] Subtest parallel-random-engines: SKIP (0.000s) [281.614223] [161/171] (723s left) gem_lmem_swapping (random-engines) [281.723133] Subtest random-engines: SKIP (0.000s) [281.763549] [162/171] (723s left) gem_lmem_swapping (verify-random) [281.872393] Subtest verify-random: SKIP (0.000s) [281.913515] [163/171] (723s left) i915_pm_rpm (module-reload) [284.571052] Starting subtest: module-reload [302.603449] Subtest module-reload: SUCCESS (18.023s) [302.643226] [164/171] (702s left) i915_selftest (live) [302.758869] Starting subtest: live [302.759966] Starting dynamic subtest: sanitycheck [304.440705] Dynamic subtest sanitycheck: SUCCESS (1.672s) [304.449213] Starting dynamic subtest: uncore [306.102884] Dynamic subtest uncore: SUCCESS (1.660s) [306.111509] Starting dynamic subtest: workarounds [308.029306] Dynamic subtest workarounds: SUCCESS (1.932s) [308.046460] Starting dynamic subtest: gt_engines [310.198651] Dynamic subtest gt_engines: SUCCESS (2.159s) [310.205696] Starting dynamic subtest: gt_timelines [321.506745] Dynamic subtest gt_timelines: SUCCESS (11.306s) [321.515199] Starting dynamic subtest: gt_contexts [323.320579] Dynamic subtest gt_contexts: SUCCESS (1.811s) [323.330935] Starting dynamic subtest: gt_lrc [327.579192] Dynamic subtest gt_lrc: SUCCESS (4.256s) [327.591638] Starting dynamic subtest: gt_mocs [329.398826] Dynamic subtest gt_mocs: SUCCESS (1.817s) [329.408198] Starting dynamic subtest: gt_pm [335.397961] Dynamic subtest gt_pm: SUCCESS (5.997s) [335.409842] Starting dynamic subtest: gt_heartbeat [337.209619] Dynamic subtest gt_heartbeat: SUCCESS (1.810s) [337.216822] Starting dynamic subtest: gt_tlb [339.781696] Dynamic subtest gt_tlb: SUCCESS (2.570s) [339.789374] Starting dynamic subtest: requests [347.258729] Dynamic subtest requests: SUCCESS (7.475s) [347.266737] Starting dynamic subtest: migrate [351.827861] Dynamic subtest migrate: SUCCESS (4.567s) [351.836260] Starting dynamic subtest: active [353.543818] Dynamic subtest active: SUCCESS (1.714s) [353.554210] Starting dynamic subtest: objects [356.404841] Dynamic subtest objects: SUCCESS (2.859s) [356.413876] Starting dynamic subtest: mman [361.630594] Dynamic subtest mman: SUCCESS (5.224s) [361.638545] Starting dynamic subtest: dmabuf [363.385980] Dynamic subtest dmabuf: SUCCESS (1.753s) [363.396854] Starting dynamic subtest: vma [365.103707] Dynamic subtest vma: SUCCESS (1.716s) [365.111461] Starting dynamic subtest: coherency [368.004757] Dynamic subtest coherency: SUCCESS (2.899s) [368.012700] Starting dynamic subtest: gtt [376.538699] Dynamic subtest gtt: SUCCESS (8.532s) [376.547230] Starting dynamic subtest: gem [378.492946] Dynamic subtest gem: SUCCESS (1.952s) [378.506417] Starting dynamic subtest: evict [381.816697] Dynamic subtest evict: SUCCESS (3.322s) [381.827492] Starting dynamic subtest: hugepages [388.778768] Dynamic subtest hugepages: SUCCESS (6.960s) [388.786508] Starting dynamic subtest: gem_contexts [403.373778] Dynamic subtest gem_contexts: SUCCESS (14.593s) [403.381543] Starting dynamic subtest: client [405.107717] Dynamic subtest client: SUCCESS (1.732s) [405.115450] Starting dynamic subtest: gem_migrate [406.763580] Dynamic subtest gem_migrate: SUCCESS (1.654s) [406.771344] Starting dynamic subtest: reset [409.169925] Dynamic subtest reset: SUCCESS (2.404s) [409.179894] Starting dynamic subtest: memory_region [410.879858] Dynamic subtest memory_region: SUCCESS (1.708s) [410.888977] Starting dynamic subtest: hangcheck [435.009878] Dynamic subtest hangcheck: SUCCESS (24.128s) [435.022257] Starting dynamic subtest: execlists [444.542755] Dynamic subtest execlists: SUCCESS (9.531s) [444.550559] Starting dynamic subtest: ring_submission [446.218539] Dynamic subtest ring_submission: SUCCESS (1.674s) [446.232823] Starting dynamic subtest: perf [448.148622] Dynamic subtest perf: SUCCESS (1.928s) [448.159083] Starting dynamic subtest: slpc [449.856690] Dynamic subtest slpc: SUCCESS (1.706s) [449.864478] Starting dynamic subtest: guc [451.527945] Dynamic subtest guc: SUCCESS (1.669s) [451.537910] Starting dynamic subtest: guc_multi_lrc [453.247535] Dynamic subtest guc_multi_lrc: SUCCESS (1.718s) [453.255216] Starting dynamic subtest: guc_hang [454.951645] Dynamic subtest guc_hang: SUCCESS (1.702s) [454.959381] Starting dynamic subtest: late_gt_pm [456.683888] Dynamic subtest late_gt_pm: SUCCESS (1.737s) [456.685126] Subtest live: SUCCESS (153.925s) [456.905845] [165/171] (548s left) dmabuf (all-tests) [457.025333] Starting subtest: all-tests [457.026765] Starting dynamic subtest: sanitycheck [457.095366] Dynamic subtest sanitycheck: SUCCESS (0.068s) [457.130102] Starting dynamic subtest: dma_fence [457.296531] Dynamic subtest dma_fence: SUCCESS (0.194s) [457.308904] Starting dynamic subtest: dma_fence_chain [473.544517] Dynamic subtest dma_fence_chain: SUCCESS (16.229s) [473.567571] Starting dynamic subtest: dma_fence_unwrap [473.625272] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s) [473.656841] Starting dynamic subtest: dma_resv [473.707407] Dynamic subtest dma_resv: SUCCESS (0.077s) [473.708448] Subtest all-tests: SUCCESS (16.683s) [473.731492] [166/171] (531s left) i915_suspend (basic-s2idle-without-i915) [473.836238] Starting subtest: basic-s2idle-without-i915 [493.417708] Subtest basic-s2idle-without-i915: SUCCESS (4.189s) [495.838202] [167/171] (526s left) i915_suspend (basic-s3-without-i915) [495.987370] Starting subtest: basic-s3-without-i915 [516.450167] Subtest basic-s3-without-i915: SUCCESS (4.442s) [519.869422] [168/171] (521s left) gem_exec_suspend (basic-s0) [520.040692] Starting subtest: basic-S0 [520.041782] Starting dynamic subtest: smem [538.540802] Dynamic subtest smem: SUCCESS (3.274s) [538.541755] Subtest basic-S0: SUCCESS (3.276s) [540.826917] [169/171] (518s left) gem_exec_suspend (basic-s3) [540.985558] Starting subtest: basic-S3 [540.988181] Starting dynamic subtest: smem [561.646834] Dynamic subtest smem: SUCCESS (4.392s) [561.647775] Subtest basic-S3: SUCCESS (4.395s) [563.932925] [170/171] (513s left) kms_chamelium_hpd (common-hpd-after-suspend) [564.441094] Subtest common-hpd-after-suspend: SKIP (0.000s) [565.317037] [171/171] (512s left) kms_pipe_crc_basic (suspend-read-crc) [565.485420] Starting subtest: suspend-read-crc [565.487532] Starting dynamic subtest: pipe-A-eDP-1 [585.591083] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.367s) [585.609375] Starting dynamic subtest: pipe-B-eDP-1 [606.289041] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.841s) [606.303192] Starting dynamic subtest: pipe-C-eDP-1 [626.820521] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.323s) [626.821445] Subtest suspend-read-crc: SUCCESS (11.544s) [630.705167] Closing watchdogs Done.